2017-09-25 02:57:37,544 [salt.cli.daemons ][WARNING ][2527] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-25 02:57:57,000 [salt.state       ][ERROR   ][3791] No contents found in top file
2017-09-25 02:58:14,985 [salt.utils.parsers][WARNING ][2527] Minion received a SIGTERM. Exiting.
2017-09-25 03:00:39,099 [salt.cli.daemons ][WARNING ][3229] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-25 03:03:43,740 [salt.loaded.int.module.cmdmod][ERROR   ][11419] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-09-25 03:03:43,741 [salt.loaded.int.module.cmdmod][ERROR   ][11419] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-09-25 03:03:43,741 [salt.loaded.int.module.cmdmod][ERROR   ][11419] retcode: 1
2017-09-25 03:03:43,742 [salt.state       ][ERROR   ][11419] {'pid': 16237, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-09-25 03:03:47,722 [py.warnings      ][WARNING ][16283] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-09-25 03:04:51,716 [salt.loaded.int.module.cmdmod][ERROR   ][16283] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 03:04:51,717 [salt.loaded.int.module.cmdmod][ERROR   ][16283] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 03:05:00,770 [salt.loaded.int.module.cmdmod][ERROR   ][16283] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 03:05:00,771 [salt.loaded.int.module.cmdmod][ERROR   ][16283] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 03:05:15,424 [salt.loaded.int.module.cmdmod][ERROR   ][16283] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 03:05:15,425 [salt.loaded.int.module.cmdmod][ERROR   ][16283] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 03:05:26,427 [salt.loaded.int.module.cmdmod][ERROR   ][16283] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 03:05:26,427 [salt.loaded.int.module.cmdmod][ERROR   ][16283] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 03:05:36,330 [salt.loaded.int.module.cmdmod][ERROR   ][16283] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 03:05:36,330 [salt.loaded.int.module.cmdmod][ERROR   ][16283] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 03:05:43,614 [salt.loaded.int.module.cmdmod][ERROR   ][16283] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-09-25 03:05:47,365 [salt.state       ][ERROR   ][23894] No contents found in top file
2017-09-25 03:05:51,701 [salt.loaded.int.module.cmdmod][INFO    ][24122] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-25 03:05:51,715 [salt.loaded.int.module.cmdmod][INFO    ][24122] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-25 03:05:51,734 [salt.loaded.int.module.cmdmod][INFO    ][24122] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-25 03:05:51,751 [salt.utils.parsers][WARNING ][3229] Minion received a SIGTERM. Exiting.
2017-09-25 03:05:52,271 [salt.cli.daemons ][INFO    ][24229] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-odl-ha.local"
2017-09-25 03:05:52,981 [salt.minion      ][INFO    ][24229] Creating minion process manager
2017-09-25 03:05:53,042 [salt.cli.daemons ][WARNING ][24229] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-25 03:05:53,043 [salt.cli.daemons ][INFO    ][24229] The Salt Minion is starting up
2017-09-25 03:05:53,043 [salt.minion      ][INFO    ][24229] Minion is starting as user 'root'
2017-09-25 03:05:53,044 [salt.utils.event ][INFO    ][24229] Starting pull socket on /var/run/salt/minion/minion_event_127643860a_pull.ipc
2017-09-25 03:05:54,391 [salt.loaded.int.module.cmdmod][INFO    ][24229] Executing command ['date', '+%z'] in directory '/root'
2017-09-25 03:05:54,415 [salt.utils.schedule][INFO    ][24229] Updating job settings for scheduled job: __mine_interval
2017-09-25 03:05:54,420 [salt.minion      ][INFO    ][24229] Added mine.update to scheduler
2017-09-25 03:05:54,658 [salt.minion      ][INFO    ][24229] Minion is ready to receive requests!
2017-09-25 03:05:55,659 [salt.utils.schedule][INFO    ][24229] Running scheduled job: __mine_interval
2017-09-25 03:06:01,847 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925030601840339
2017-09-25 03:06:01,869 [salt.minion      ][INFO    ][24329] Starting a new job with PID 24329
2017-09-25 03:06:01,890 [salt.minion      ][INFO    ][24329] Returning information for job: 20170925030601840339
2017-09-25 03:06:22,996 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command state.sls with jid 20170925030622987743
2017-09-25 03:06:23,018 [salt.minion      ][INFO    ][24342] Starting a new job with PID 24342
2017-09-25 03:06:25,469 [salt.state       ][INFO    ][24342] Loading fresh modules for state activity
2017-09-25 03:06:25,512 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-25 03:06:25,552 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-25 03:06:25,594 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:06:25,706 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-25 03:06:25,723 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-25 03:06:25,755 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:06:25,889 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-25 03:06:25,910 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 03:06:25,986 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-25 03:06:26,008 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-25 03:06:26,022 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 03:06:26,039 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-25 03:06:26,047 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-25 03:06:26,083 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-25 03:06:26,167 [py.warnings      ][WARNING ][24342] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-09-25 03:06:26,167 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'salt-minion --version' in directory '/root'
2017-09-25 03:06:26,550 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-25 03:06:26,575 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-25 03:06:26,590 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-25 03:06:26,604 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-25 03:06:26,665 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-25 03:06:26,786 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-25 03:06:27,001 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-25 03:06:27,054 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:06:27,122 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-25 03:06:27,224 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 03:06:27,312 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-25 03:06:27,347 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-25 03:06:27,366 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 03:06:27,385 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-25 03:06:27,396 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-25 03:06:27,483 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-25 03:06:27,517 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'salt-minion --version' in directory '/root'
2017-09-25 03:06:27,915 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-25 03:06:28,058 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-25 03:06:28,085 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-25 03:06:28,100 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-25 03:06:28,166 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-25 03:06:28,209 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-25 03:06:28,353 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-25 03:06:28,426 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:06:29,098 [salt.state       ][INFO    ][24342] Running state [salt-minion] at time 03:06:29.097917
2017-09-25 03:06:29,098 [salt.state       ][INFO    ][24342] Executing state pkg.installed for salt-minion
2017-09-25 03:06:29,099 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:06:29,545 [salt.state       ][INFO    ][24342] Package salt-minion is already installed
2017-09-25 03:06:29,545 [salt.state       ][INFO    ][24342] Completed state [salt-minion] at time 03:06:29.545341 duration_in_ms=447.425
2017-09-25 03:06:29,546 [salt.state       ][INFO    ][24342] Running state [python-yaml] at time 03:06:29.545630
2017-09-25 03:06:29,546 [salt.state       ][INFO    ][24342] Executing state pkg.installed for python-yaml
2017-09-25 03:06:29,550 [salt.state       ][INFO    ][24342] Package python-yaml is already installed
2017-09-25 03:06:29,550 [salt.state       ][INFO    ][24342] Completed state [python-yaml] at time 03:06:29.550083 duration_in_ms=4.453
2017-09-25 03:06:29,550 [salt.state       ][INFO    ][24342] Running state [python-psutil] at time 03:06:29.550305
2017-09-25 03:06:29,551 [salt.state       ][INFO    ][24342] Executing state pkg.installed for python-psutil
2017-09-25 03:06:29,555 [salt.state       ][INFO    ][24342] Package python-psutil is already installed
2017-09-25 03:06:29,659 [salt.state       ][INFO    ][24342] Completed state [python-psutil] at time 03:06:29.658381 duration_in_ms=108.073
2017-09-25 03:06:29,659 [salt.state       ][INFO    ][24342] Running state [python-m2crypto] at time 03:06:29.659087
2017-09-25 03:06:29,660 [salt.state       ][INFO    ][24342] Executing state pkg.installed for python-m2crypto
2017-09-25 03:06:29,668 [salt.state       ][INFO    ][24342] Package python-m2crypto is already installed
2017-09-25 03:06:29,673 [salt.state       ][INFO    ][24342] Completed state [python-m2crypto] at time 03:06:29.672932 duration_in_ms=13.845
2017-09-25 03:06:29,677 [salt.state       ][INFO    ][24342] Running state [/etc/salt/minion.d/minion.conf] at time 03:06:29.677194
2017-09-25 03:06:29,678 [salt.state       ][INFO    ][24342] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-25 03:06:29,707 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-25 03:06:29,792 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:06:29,863 [salt.fileclient  ][INFO    ][24342] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 03:06:29,909 [salt.state       ][INFO    ][24342] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-25 03:06:29,909 [salt.state       ][INFO    ][24342] Completed state [/etc/salt/minion.d/minion.conf] at time 03:06:29.908792 duration_in_ms=231.599
2017-09-25 03:06:29,909 [salt.state       ][INFO    ][24342] Running state [/etc/salt/minion.d/_virt.conf] at time 03:06:29.909245
2017-09-25 03:06:29,909 [salt.state       ][INFO    ][24342] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-25 03:06:29,940 [salt.state       ][INFO    ][24342] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-25 03:06:29,940 [salt.state       ][INFO    ][24342] Completed state [/etc/salt/minion.d/_virt.conf] at time 03:06:29.939893 duration_in_ms=30.645
2017-09-25 03:06:29,943 [salt.state       ][INFO    ][24342] Running state [salt-minion] at time 03:06:29.942458
2017-09-25 03:06:29,943 [salt.state       ][INFO    ][24342] Executing state service.running for salt-minion
2017-09-25 03:06:29,944 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-25 03:06:29,971 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-25 03:06:30,026 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-25 03:06:30,041 [salt.state       ][INFO    ][24342] The service salt-minion is already running
2017-09-25 03:06:30,042 [salt.state       ][INFO    ][24342] Completed state [salt-minion] at time 03:06:30.041790 duration_in_ms=99.331
2017-09-25 03:06:30,044 [salt.state       ][INFO    ][24342] Running state [/etc/salt/grains.d] at time 03:06:30.044147
2017-09-25 03:06:30,045 [salt.state       ][INFO    ][24342] Executing state file.directory for /etc/salt/grains.d
2017-09-25 03:06:30,046 [salt.state       ][INFO    ][24342] Directory /etc/salt/grains.d is in the correct state
2017-09-25 03:06:30,046 [salt.state       ][INFO    ][24342] Completed state [/etc/salt/grains.d] at time 03:06:30.046363 duration_in_ms=2.216
2017-09-25 03:06:30,047 [salt.state       ][INFO    ][24342] Running state [/etc/salt/grains] at time 03:06:30.047371
2017-09-25 03:06:30,048 [salt.state       ][INFO    ][24342] Executing state file.managed for /etc/salt/grains
2017-09-25 03:06:30,049 [salt.state       ][INFO    ][24342] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-25 03:06:30,049 [salt.state       ][INFO    ][24342] Completed state [/etc/salt/grains] at time 03:06:30.048796 duration_in_ms=1.425
2017-09-25 03:06:30,049 [salt.state       ][INFO    ][24342] Running state [/etc/salt/grains.d/placeholder] at time 03:06:30.049443
2017-09-25 03:06:30,050 [salt.state       ][INFO    ][24342] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-25 03:06:30,050 [salt.state       ][INFO    ][24342] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-25 03:06:30,051 [salt.state       ][INFO    ][24342] Completed state [/etc/salt/grains.d/placeholder] at time 03:06:30.050731 duration_in_ms=1.287
2017-09-25 03:06:30,051 [salt.state       ][INFO    ][24342] Running state [/etc/salt/grains.d/sphinx] at time 03:06:30.051337
2017-09-25 03:06:30,052 [salt.state       ][INFO    ][24342] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-25 03:06:30,129 [salt.state       ][INFO    ][24342] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.141
               - 127.0.0.1
               - 192.168.11.251
-              - 192.168.122.1
         system:
           name: System
           param:

2017-09-25 03:06:30,130 [salt.state       ][INFO    ][24342] Completed state [/etc/salt/grains.d/sphinx] at time 03:06:30.129493 duration_in_ms=78.155
2017-09-25 03:06:30,131 [salt.state       ][INFO    ][24342] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:06:30.130752
2017-09-25 03:06:30,131 [salt.state       ][INFO    ][24342] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:06:30,132 [salt.state       ][INFO    ][24342] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:06:30,132 [salt.state       ][INFO    ][24342] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:06:30.132111 duration_in_ms=1.359
2017-09-25 03:06:30,133 [salt.state       ][INFO    ][24342] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:06:30.132452
2017-09-25 03:06:30,133 [salt.state       ][INFO    ][24342] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:06:30,134 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-09-25 03:06:30,280 [salt.state       ][INFO    ][24342] {'pid': 24392, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-09-25 03:06:30,280 [salt.state       ][INFO    ][24342] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:06:30.280058 duration_in_ms=147.607
2017-09-25 03:06:30,281 [salt.state       ][INFO    ][24342] Running state [/etc/salt/grains.d/dns_records] at time 03:06:30.280641
2017-09-25 03:06:30,281 [salt.state       ][INFO    ][24342] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-25 03:06:30,375 [salt.state       ][INFO    ][24342] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-25 03:06:30,375 [salt.state       ][INFO    ][24342] Completed state [/etc/salt/grains.d/dns_records] at time 03:06:30.375280 duration_in_ms=94.638
2017-09-25 03:06:30,377 [salt.state       ][INFO    ][24342] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 03:06:30.376551
2017-09-25 03:06:30,377 [salt.state       ][INFO    ][24342] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:06:30,377 [salt.state       ][INFO    ][24342] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:06:30,378 [salt.state       ][INFO    ][24342] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 03:06:30.377714 duration_in_ms=1.163
2017-09-25 03:06:30,378 [salt.state       ][INFO    ][24342] Running state [/etc/salt/grains.d/salt] at time 03:06:30.378374
2017-09-25 03:06:30,379 [salt.state       ][INFO    ][24342] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-25 03:06:30,519 [salt.state       ][INFO    ][24342] File /etc/salt/grains.d/salt is in the correct state
2017-09-25 03:06:30,520 [salt.state       ][INFO    ][24342] Completed state [/etc/salt/grains.d/salt] at time 03:06:30.519478 duration_in_ms=141.102
2017-09-25 03:06:30,521 [salt.state       ][INFO    ][24342] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 03:06:30.520848
2017-09-25 03:06:30,521 [salt.state       ][INFO    ][24342] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:06:30,522 [salt.state       ][INFO    ][24342] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:06:30,522 [salt.state       ][INFO    ][24342] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 03:06:30.522026 duration_in_ms=1.179
2017-09-25 03:06:30,525 [salt.state       ][INFO    ][24342] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:06:30.524951
2017-09-25 03:06:30,525 [salt.state       ][INFO    ][24342] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-25 03:06:30,526 [salt.state       ][INFO    ][24342] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-25 03:06:30,526 [salt.state       ][INFO    ][24342] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:06:30.526067 duration_in_ms=1.116
2017-09-25 03:06:30,526 [salt.state       ][INFO    ][24342] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:06:30.526344
2017-09-25 03:06:30,527 [salt.state       ][INFO    ][24342] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-25 03:06:30,529 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-09-25 03:06:30,543 [salt.state       ][INFO    ][24342] {'pid': 24394, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-09-25 03:06:30,544 [salt.state       ][INFO    ][24342] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:06:30.544000 duration_in_ms=17.655
2017-09-25 03:06:30,545 [salt.state       ][INFO    ][24342] Running state [mine.update] at time 03:06:30.545291
2017-09-25 03:06:30,546 [salt.state       ][INFO    ][24342] Executing state module.wait for mine.update
2017-09-25 03:06:30,546 [salt.state       ][INFO    ][24342] No changes made for mine.update
2017-09-25 03:06:30,547 [salt.state       ][INFO    ][24342] Completed state [mine.update] at time 03:06:30.546452 duration_in_ms=1.161
2017-09-25 03:06:30,547 [salt.state       ][INFO    ][24342] Running state [mine.update] at time 03:06:30.546748
2017-09-25 03:06:30,547 [salt.state       ][INFO    ][24342] Executing state module.mod_watch for mine.update
2017-09-25 03:06:31,079 [salt.state       ][INFO    ][24342] {'ret': True}
2017-09-25 03:06:31,080 [salt.state       ][INFO    ][24342] Completed state [mine.update] at time 03:06:31.079798 duration_in_ms=533.049
2017-09-25 03:06:31,080 [salt.state       ][INFO    ][24342] Running state [ca-certificates] at time 03:06:31.080269
2017-09-25 03:06:31,081 [salt.state       ][INFO    ][24342] Executing state pkg.installed for ca-certificates
2017-09-25 03:06:31,088 [salt.state       ][INFO    ][24342] Package ca-certificates is already installed
2017-09-25 03:06:31,088 [salt.state       ][INFO    ][24342] Completed state [ca-certificates] at time 03:06:31.088063 duration_in_ms=7.794
2017-09-25 03:06:31,089 [salt.state       ][INFO    ][24342] Running state [update-ca-certificates] at time 03:06:31.089160
2017-09-25 03:06:31,090 [salt.state       ][INFO    ][24342] Executing state cmd.wait for update-ca-certificates
2017-09-25 03:06:31,090 [salt.state       ][INFO    ][24342] No changes made for update-ca-certificates
2017-09-25 03:06:31,090 [salt.state       ][INFO    ][24342] Completed state [update-ca-certificates] at time 03:06:31.090208 duration_in_ms=1.049
2017-09-25 03:06:31,091 [salt.state       ][INFO    ][24342] Running state [libvirt-dev] at time 03:06:31.090527
2017-09-25 03:06:31,091 [salt.state       ][INFO    ][24342] Executing state pkg.installed for libvirt-dev
2017-09-25 03:06:31,097 [salt.state       ][INFO    ][24342] Package libvirt-dev is already installed
2017-09-25 03:06:31,097 [salt.state       ][INFO    ][24342] Completed state [libvirt-dev] at time 03:06:31.097194 duration_in_ms=6.667
2017-09-25 03:06:31,098 [salt.state       ][INFO    ][24342] Running state [pkg-config] at time 03:06:31.097498
2017-09-25 03:06:31,098 [salt.state       ][INFO    ][24342] Executing state pkg.installed for pkg-config
2017-09-25 03:06:31,104 [salt.state       ][INFO    ][24342] Package pkg-config is already installed
2017-09-25 03:06:31,104 [salt.state       ][INFO    ][24342] Completed state [pkg-config] at time 03:06:31.103846 duration_in_ms=6.347
2017-09-25 03:06:31,104 [salt.state       ][INFO    ][24342] Running state [virtng.init] at time 03:06:31.104154
2017-09-25 03:06:31,104 [salt.state       ][INFO    ][24342] Executing state module.run for virtng.init
2017-09-25 03:06:31,201 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command ['git', '--version'] in directory '/root'
2017-09-25 03:06:31,301 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:31,336 [salt.state       ][INFO    ][24342] unless execution succeeded
2017-09-25 03:06:31,337 [salt.state       ][INFO    ][24342] Completed state [virtng.init] at time 03:06:31.336861 duration_in_ms=232.706
2017-09-25 03:06:31,337 [salt.state       ][INFO    ][24342] Running state [virt.set_autostart] at time 03:06:31.337353
2017-09-25 03:06:31,338 [salt.state       ][INFO    ][24342] Executing state module.run for virt.set_autostart
2017-09-25 03:06:31,342 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:31,376 [salt.state       ][INFO    ][24342] unless execution succeeded
2017-09-25 03:06:31,391 [salt.state       ][INFO    ][24342] Completed state [virt.set_autostart] at time 03:06:31.390828 duration_in_ms=53.473
2017-09-25 03:06:31,392 [salt.state       ][INFO    ][24342] Running state [virtng.init] at time 03:06:31.391828
2017-09-25 03:06:31,392 [salt.state       ][INFO    ][24342] Executing state module.run for virtng.init
2017-09-25 03:06:31,397 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:31,429 [salt.state       ][INFO    ][24342] unless execution succeeded
2017-09-25 03:06:31,430 [salt.state       ][INFO    ][24342] Completed state [virtng.init] at time 03:06:31.429757 duration_in_ms=37.929
2017-09-25 03:06:31,430 [salt.state       ][INFO    ][24342] Running state [virt.set_autostart] at time 03:06:31.430284
2017-09-25 03:06:31,431 [salt.state       ][INFO    ][24342] Executing state module.run for virt.set_autostart
2017-09-25 03:06:31,436 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:31,470 [salt.state       ][INFO    ][24342] unless execution succeeded
2017-09-25 03:06:31,478 [salt.state       ][INFO    ][24342] Completed state [virt.set_autostart] at time 03:06:31.477625 duration_in_ms=47.341
2017-09-25 03:06:31,478 [salt.state       ][INFO    ][24342] Running state [virtng.init] at time 03:06:31.478155
2017-09-25 03:06:31,479 [salt.state       ][INFO    ][24342] Executing state module.run for virtng.init
2017-09-25 03:06:31,483 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:31,518 [salt.state       ][INFO    ][24342] unless execution succeeded
2017-09-25 03:06:31,518 [salt.state       ][INFO    ][24342] Completed state [virtng.init] at time 03:06:31.518330 duration_in_ms=40.175
2017-09-25 03:06:31,519 [salt.state       ][INFO    ][24342] Running state [virt.set_autostart] at time 03:06:31.518853
2017-09-25 03:06:31,519 [salt.state       ][INFO    ][24342] Executing state module.run for virt.set_autostart
2017-09-25 03:06:31,524 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:31,555 [salt.state       ][INFO    ][24342] unless execution succeeded
2017-09-25 03:06:31,556 [salt.state       ][INFO    ][24342] Completed state [virt.set_autostart] at time 03:06:31.555454 duration_in_ms=36.6
2017-09-25 03:06:31,556 [salt.state       ][INFO    ][24342] Running state [virtng.init] at time 03:06:31.555994
2017-09-25 03:06:31,556 [salt.state       ][INFO    ][24342] Executing state module.run for virtng.init
2017-09-25 03:06:31,561 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:31,595 [salt.state       ][INFO    ][24342] unless execution succeeded
2017-09-25 03:06:31,595 [salt.state       ][INFO    ][24342] Completed state [virtng.init] at time 03:06:31.595194 duration_in_ms=39.2
2017-09-25 03:06:31,596 [salt.state       ][INFO    ][24342] Running state [virt.set_autostart] at time 03:06:31.595677
2017-09-25 03:06:31,596 [salt.state       ][INFO    ][24342] Executing state module.run for virt.set_autostart
2017-09-25 03:06:31,600 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:31,631 [salt.state       ][INFO    ][24342] unless execution succeeded
2017-09-25 03:06:31,632 [salt.state       ][INFO    ][24342] Completed state [virt.set_autostart] at time 03:06:31.631711 duration_in_ms=36.035
2017-09-25 03:06:31,632 [salt.state       ][INFO    ][24342] Running state [virtng.init] at time 03:06:31.632167
2017-09-25 03:06:31,633 [salt.state       ][INFO    ][24342] Executing state module.run for virtng.init
2017-09-25 03:06:31,637 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:31,666 [salt.state       ][INFO    ][24342] unless execution succeeded
2017-09-25 03:06:31,709 [salt.state       ][INFO    ][24342] Completed state [virtng.init] at time 03:06:31.708960 duration_in_ms=76.792
2017-09-25 03:06:31,710 [salt.state       ][INFO    ][24342] Running state [virt.set_autostart] at time 03:06:31.709548
2017-09-25 03:06:31,710 [salt.state       ][INFO    ][24342] Executing state module.run for virt.set_autostart
2017-09-25 03:06:31,715 [salt.loaded.int.module.cmdmod][INFO    ][24342] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:31,747 [salt.state       ][INFO    ][24342] unless execution succeeded
2017-09-25 03:06:31,747 [salt.state       ][INFO    ][24342] Completed state [virt.set_autostart] at time 03:06:31.746985 duration_in_ms=37.436
2017-09-25 03:06:31,753 [salt.minion      ][INFO    ][24342] Returning information for job: 20170925030622987743
2017-09-25 03:06:32,878 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command pillar.get with jid 20170925030632872580
2017-09-25 03:06:32,900 [salt.minion      ][INFO    ][24447] Starting a new job with PID 24447
2017-09-25 03:06:32,905 [salt.minion      ][INFO    ][24447] Returning information for job: 20170925030632872580
2017-09-25 03:07:20,741 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170925030720732759
2017-09-25 03:07:20,767 [salt.minion      ][INFO    ][24463] Starting a new job with PID 24463
2017-09-25 03:07:23,990 [salt.state       ][INFO    ][24463] Loading fresh modules for state activity
2017-09-25 03:07:24,331 [salt.state       ][ERROR   ][24463] No contents found in top file
2017-09-25 03:07:24,333 [salt.utils.extmods][INFO    ][24463] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-25 03:07:24,339 [salt.utils.extmods][INFO    ][24463] Syncing beacons for environment 'base'
2017-09-25 03:07:24,339 [salt.utils.extmods][INFO    ][24463] Loading cache from salt://_beacons, for base)
2017-09-25 03:07:24,340 [salt.fileclient  ][INFO    ][24463] Caching directory '_beacons/' for environment 'base'
2017-09-25 03:07:24,377 [salt.utils.extmods][INFO    ][24463] Syncing modules for environment 'base'
2017-09-25 03:07:24,377 [salt.utils.extmods][INFO    ][24463] Loading cache from salt://_modules, for base)
2017-09-25 03:07:24,378 [salt.fileclient  ][INFO    ][24463] Caching directory '_modules/' for environment 'base'
2017-09-25 03:07:24,499 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-25 03:07:24,583 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-25 03:07:24,600 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-25 03:07:24,634 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-25 03:07:24,683 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-25 03:07:24,742 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-25 03:07:24,793 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-25 03:07:24,822 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-25 03:07:24,892 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-25 03:07:24,921 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-25 03:07:24,967 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-25 03:07:24,999 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-25 03:07:25,041 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-25 03:07:25,122 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-25 03:07:25,138 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-25 03:07:25,162 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-25 03:07:25,243 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-25 03:07:25,256 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-25 03:07:25,289 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-25 03:07:25,340 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-25 03:07:25,364 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-25 03:07:25,407 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-25 03:07:25,464 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-25 03:07:25,492 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-25 03:07:25,523 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-25 03:07:25,550 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-25 03:07:25,561 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-25 03:07:25,583 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-25 03:07:25,648 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-25 03:07:25,673 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-25 03:07:25,714 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-25 03:07:25,731 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-25 03:07:25,736 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-25 03:07:25,736 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-25 03:07:25,736 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-25 03:07:25,737 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-25 03:07:25,737 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-25 03:07:25,738 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-25 03:07:25,738 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-25 03:07:25,738 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-25 03:07:25,739 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-25 03:07:25,739 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-25 03:07:25,740 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-25 03:07:25,740 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-25 03:07:25,740 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-25 03:07:25,741 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-25 03:07:25,741 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-25 03:07:25,741 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-25 03:07:25,742 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-25 03:07:25,742 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-25 03:07:25,743 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-25 03:07:25,743 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-25 03:07:25,743 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-25 03:07:25,744 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-25 03:07:25,744 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-25 03:07:25,745 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-25 03:07:25,745 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-25 03:07:25,745 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-25 03:07:25,746 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-25 03:07:25,746 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-25 03:07:25,746 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-25 03:07:25,747 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-25 03:07:25,747 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-25 03:07:25,747 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-09-25 03:07:25,748 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-25 03:07:25,748 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-25 03:07:25,758 [salt.utils.extmods][INFO    ][24463] Syncing states for environment 'base'
2017-09-25 03:07:25,758 [salt.utils.extmods][INFO    ][24463] Loading cache from salt://_states, for base)
2017-09-25 03:07:25,758 [salt.fileclient  ][INFO    ][24463] Caching directory '_states/' for environment 'base'
2017-09-25 03:07:25,870 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-25 03:07:25,884 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-25 03:07:25,903 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-25 03:07:25,948 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-25 03:07:25,966 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-25 03:07:25,984 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-25 03:07:25,1000 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-25 03:07:26,016 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-25 03:07:26,063 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-25 03:07:26,080 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-25 03:07:26,103 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-25 03:07:26,150 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-25 03:07:26,163 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-25 03:07:26,472 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-25 03:07:26,725 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-25 03:07:26,747 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-25 03:07:26,762 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-25 03:07:26,775 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-25 03:07:26,873 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-25 03:07:26,893 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-25 03:07:26,925 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-25 03:07:26,948 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-25 03:07:26,967 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-25 03:07:26,999 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-25 03:07:27,019 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-25 03:07:27,032 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-25 03:07:27,045 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-25 03:07:27,058 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-25 03:07:27,067 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-25 03:07:27,071 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-25 03:07:27,072 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-25 03:07:27,073 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-25 03:07:27,073 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-25 03:07:27,073 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-25 03:07:27,074 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-25 03:07:27,074 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-25 03:07:27,075 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-25 03:07:27,075 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-25 03:07:27,076 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-25 03:07:27,076 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-25 03:07:27,077 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-25 03:07:27,077 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-25 03:07:27,078 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-25 03:07:27,078 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-25 03:07:27,079 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-25 03:07:27,079 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-25 03:07:27,079 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-25 03:07:27,080 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-25 03:07:27,080 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-25 03:07:27,081 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-25 03:07:27,081 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-25 03:07:27,082 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-25 03:07:27,082 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-25 03:07:27,083 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-25 03:07:27,083 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-25 03:07:27,084 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-25 03:07:27,084 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-25 03:07:27,085 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-25 03:07:27,085 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-25 03:07:27,088 [salt.utils.extmods][INFO    ][24463] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-25 03:07:27,094 [salt.utils.extmods][INFO    ][24463] Syncing sdb for environment 'base'
2017-09-25 03:07:27,094 [salt.utils.extmods][INFO    ][24463] Loading cache from salt://_sdb, for base)
2017-09-25 03:07:27,095 [salt.fileclient  ][INFO    ][24463] Caching directory '_sdb/' for environment 'base'
2017-09-25 03:07:27,129 [salt.utils.extmods][INFO    ][24463] Syncing grains for environment 'base'
2017-09-25 03:07:27,129 [salt.utils.extmods][INFO    ][24463] Loading cache from salt://_grains, for base)
2017-09-25 03:07:27,129 [salt.fileclient  ][INFO    ][24463] Caching directory '_grains/' for environment 'base'
2017-09-25 03:07:27,191 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-25 03:07:27,203 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-25 03:07:27,607 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-25 03:07:27,638 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-25 03:07:27,672 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-25 03:07:27,916 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-25 03:07:27,923 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-25 03:07:27,931 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-25 03:07:27,937 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-25 03:07:27,944 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-25 03:07:27,955 [salt.fileclient  ][INFO    ][24463] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-25 03:07:27,958 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-25 03:07:27,958 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-25 03:07:27,958 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-25 03:07:27,959 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-25 03:07:27,959 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-25 03:07:27,959 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-25 03:07:27,959 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-25 03:07:27,959 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-25 03:07:27,960 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-25 03:07:27,960 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-25 03:07:27,960 [salt.utils.extmods][INFO    ][24463] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-25 03:07:27,961 [salt.utils.extmods][INFO    ][24463] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-25 03:07:27,965 [salt.utils.extmods][INFO    ][24463] Syncing renderers for environment 'base'
2017-09-25 03:07:27,965 [salt.utils.extmods][INFO    ][24463] Loading cache from salt://_renderers, for base)
2017-09-25 03:07:27,966 [salt.fileclient  ][INFO    ][24463] Caching directory '_renderers/' for environment 'base'
2017-09-25 03:07:27,986 [salt.utils.extmods][INFO    ][24463] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-25 03:07:27,989 [salt.utils.extmods][INFO    ][24463] Syncing returners for environment 'base'
2017-09-25 03:07:27,990 [salt.utils.extmods][INFO    ][24463] Loading cache from salt://_returners, for base)
2017-09-25 03:07:27,990 [salt.fileclient  ][INFO    ][24463] Caching directory '_returners/' for environment 'base'
2017-09-25 03:07:28,010 [salt.utils.extmods][INFO    ][24463] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-25 03:07:28,013 [salt.utils.extmods][INFO    ][24463] Syncing output for environment 'base'
2017-09-25 03:07:28,014 [salt.utils.extmods][INFO    ][24463] Loading cache from salt://_output, for base)
2017-09-25 03:07:28,014 [salt.fileclient  ][INFO    ][24463] Caching directory '_output/' for environment 'base'
2017-09-25 03:07:28,046 [salt.utils.extmods][INFO    ][24463] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-25 03:07:28,049 [salt.utils.extmods][INFO    ][24463] Syncing utils for environment 'base'
2017-09-25 03:07:28,049 [salt.utils.extmods][INFO    ][24463] Loading cache from salt://_utils, for base)
2017-09-25 03:07:28,049 [salt.fileclient  ][INFO    ][24463] Caching directory '_utils/' for environment 'base'
2017-09-25 03:07:28,068 [salt.utils.extmods][INFO    ][24463] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-25 03:07:28,070 [salt.utils.extmods][INFO    ][24463] Syncing log_handlers for environment 'base'
2017-09-25 03:07:28,071 [salt.utils.extmods][INFO    ][24463] Loading cache from salt://_log_handlers, for base)
2017-09-25 03:07:28,071 [salt.fileclient  ][INFO    ][24463] Caching directory '_log_handlers/' for environment 'base'
2017-09-25 03:07:28,089 [salt.utils.extmods][INFO    ][24463] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-25 03:07:28,092 [salt.utils.extmods][INFO    ][24463] Syncing proxy for environment 'base'
2017-09-25 03:07:28,092 [salt.utils.extmods][INFO    ][24463] Loading cache from salt://_proxy, for base)
2017-09-25 03:07:28,092 [salt.fileclient  ][INFO    ][24463] Caching directory '_proxy/' for environment 'base'
2017-09-25 03:07:28,110 [salt.utils.extmods][INFO    ][24463] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-25 03:07:28,112 [salt.utils.extmods][INFO    ][24463] Syncing engines for environment 'base'
2017-09-25 03:07:28,113 [salt.utils.extmods][INFO    ][24463] Loading cache from salt://_engines, for base)
2017-09-25 03:07:28,113 [salt.fileclient  ][INFO    ][24463] Caching directory '_engines/' for environment 'base'
2017-09-25 03:07:28,134 [salt.minion      ][INFO    ][24463] Returning information for job: 20170925030720732759
2017-09-25 03:14:12,277 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command pkg.upgrade with jid 20170925031412265333
2017-09-25 03:14:12,301 [salt.minion      ][INFO    ][24635] Starting a new job with PID 24635
2017-09-25 03:14:12,394 [salt.loaded.int.module.cmdmod][INFO    ][24635] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:14:12,720 [salt.loaded.int.module.cmdmod][INFO    ][24635] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-09-25 03:14:22,319 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925031422305454
2017-09-25 03:14:22,342 [salt.minion      ][INFO    ][24675] Starting a new job with PID 24675
2017-09-25 03:14:22,362 [salt.minion      ][INFO    ][24675] Returning information for job: 20170925031422305454
2017-09-25 03:14:32,475 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925031432461809
2017-09-25 03:14:32,498 [salt.minion      ][INFO    ][24806] Starting a new job with PID 24806
2017-09-25 03:14:32,519 [salt.minion      ][INFO    ][24806] Returning information for job: 20170925031432461809
2017-09-25 03:14:42,554 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925031442541721
2017-09-25 03:14:42,580 [salt.minion      ][INFO    ][24853] Starting a new job with PID 24853
2017-09-25 03:14:42,615 [salt.minion      ][INFO    ][24853] Returning information for job: 20170925031442541721
2017-09-25 03:14:52,612 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925031452597721
2017-09-25 03:14:52,636 [salt.minion      ][INFO    ][25390] Starting a new job with PID 25390
2017-09-25 03:14:52,656 [salt.minion      ][INFO    ][25390] Returning information for job: 20170925031452597721
2017-09-25 03:15:02,683 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925031502667741
2017-09-25 03:15:02,707 [salt.minion      ][INFO    ][25464] Starting a new job with PID 25464
2017-09-25 03:15:02,733 [salt.minion      ][INFO    ][25464] Returning information for job: 20170925031502667741
2017-09-25 03:15:03,656 [salt.loaded.int.module.cmdmod][INFO    ][24635] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:15:03,704 [salt.minion      ][INFO    ][24635] Returning information for job: 20170925031412265333
2017-09-25 03:19:47,059 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command pkg.upgrade with jid 20170925031947046703
2017-09-25 03:19:47,082 [salt.minion      ][INFO    ][25552] Starting a new job with PID 25552
2017-09-25 03:19:47,177 [salt.loaded.int.module.cmdmod][INFO    ][25552] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:19:47,547 [salt.loaded.int.module.cmdmod][INFO    ][25552] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-09-25 03:19:47,894 [salt.loaded.int.module.cmdmod][INFO    ][25552] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:19:47,948 [salt.minion      ][INFO    ][25552] Returning information for job: 20170925031947046703
2017-09-25 03:20:18,232 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command pkg.upgrade with jid 20170925032018220154
2017-09-25 03:20:18,253 [salt.minion      ][INFO    ][25580] Starting a new job with PID 25580
2017-09-25 03:20:18,340 [salt.loaded.int.module.cmdmod][INFO    ][25580] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:20:18,737 [salt.loaded.int.module.cmdmod][INFO    ][25580] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-09-25 03:20:19,079 [salt.loaded.int.module.cmdmod][INFO    ][25580] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:20:19,138 [salt.minion      ][INFO    ][25580] Returning information for job: 20170925032018220154
2017-09-25 03:20:49,373 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command pkg.upgrade with jid 20170925032049357280
2017-09-25 03:20:49,395 [salt.minion      ][INFO    ][25612] Starting a new job with PID 25612
2017-09-25 03:20:49,488 [salt.loaded.int.module.cmdmod][INFO    ][25612] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:20:49,828 [salt.loaded.int.module.cmdmod][INFO    ][25612] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-09-25 03:20:50,156 [salt.loaded.int.module.cmdmod][INFO    ][25612] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:20:50,181 [salt.minion      ][INFO    ][25612] Returning information for job: 20170925032049357280
2017-09-25 03:21:20,725 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command pkg.upgrade with jid 20170925032120712631
2017-09-25 03:21:20,749 [salt.minion      ][INFO    ][25669] Starting a new job with PID 25669
2017-09-25 03:21:20,872 [salt.loaded.int.module.cmdmod][INFO    ][25669] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:21:21,194 [salt.loaded.int.module.cmdmod][INFO    ][25669] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-09-25 03:21:21,569 [salt.loaded.int.module.cmdmod][INFO    ][25669] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:21:21,605 [salt.minion      ][INFO    ][25669] Returning information for job: 20170925032120712631
2017-09-25 03:21:51,930 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command pkg.upgrade with jid 20170925032151914251
2017-09-25 03:21:51,952 [salt.minion      ][INFO    ][25705] Starting a new job with PID 25705
2017-09-25 03:21:52,031 [salt.loaded.int.module.cmdmod][INFO    ][25705] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:21:52,428 [salt.loaded.int.module.cmdmod][INFO    ][25705] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-09-25 03:21:52,756 [salt.loaded.int.module.cmdmod][INFO    ][25705] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:21:52,788 [salt.minion      ][INFO    ][25705] Returning information for job: 20170925032151914251
2017-09-25 03:33:54,289 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command test.ping with jid 20170925033354279047
2017-09-25 03:33:54,313 [salt.minion      ][INFO    ][25971] Starting a new job with PID 25971
2017-09-25 03:33:54,374 [salt.minion      ][INFO    ][25971] Returning information for job: 20170925033354279047
2017-09-25 03:34:56,221 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command state.sls with jid 20170925033456208858
2017-09-25 03:34:56,244 [salt.minion      ][INFO    ][25986] Starting a new job with PID 25986
2017-09-25 03:34:57,838 [salt.state       ][INFO    ][25986] Loading fresh modules for state activity
2017-09-25 03:34:57,883 [salt.fileclient  ][INFO    ][25986] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-25 03:34:57,909 [salt.fileclient  ][INFO    ][25986] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-25 03:34:57,948 [salt.fileclient  ][INFO    ][25986] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 03:34:58,389 [salt.state       ][INFO    ][25986] Running state [lsof] at time 03:34:58.388737
2017-09-25 03:34:58,389 [salt.state       ][INFO    ][25986] Executing state pkg.installed for lsof
2017-09-25 03:34:58,389 [salt.loaded.int.module.cmdmod][INFO    ][25986] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:34:58,698 [salt.state       ][INFO    ][25986] Package lsof is already installed
2017-09-25 03:34:58,698 [salt.state       ][INFO    ][25986] Completed state [lsof] at time 03:34:58.698104 duration_in_ms=309.367
2017-09-25 03:34:58,698 [salt.state       ][INFO    ][25986] Running state [keepalived] at time 03:34:58.698315
2017-09-25 03:34:58,699 [salt.state       ][INFO    ][25986] Executing state pkg.installed for keepalived
2017-09-25 03:34:58,719 [salt.loaded.int.module.cmdmod][INFO    ][25986] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-25 03:35:01,052 [salt.loaded.int.module.cmdmod][INFO    ][25986] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-09-25 03:35:06,324 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925033506309274
2017-09-25 03:35:06,346 [salt.minion      ][INFO    ][27252] Starting a new job with PID 27252
2017-09-25 03:35:06,366 [salt.minion      ][INFO    ][27252] Returning information for job: 20170925033506309274
2017-09-25 03:35:09,669 [salt.loaded.int.module.cmdmod][INFO    ][25986] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:35:09,723 [salt.state       ][INFO    ][25986] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-09-25 03:35:09,741 [salt.state       ][INFO    ][25986] Loading fresh modules for state activity
2017-09-25 03:35:09,772 [salt.state       ][INFO    ][25986] Completed state [keepalived] at time 03:35:09.771495 duration_in_ms=11073.178
2017-09-25 03:35:09,776 [salt.state       ][INFO    ][25986] Running state [/etc/keepalived/keepalived.conf] at time 03:35:09.775912
2017-09-25 03:35:09,776 [salt.state       ][INFO    ][25986] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-25 03:35:09,811 [salt.fileclient  ][INFO    ][25986] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-25 03:35:09,856 [salt.fileclient  ][INFO    ][25986] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 03:35:09,867 [salt.state       ][INFO    ][25986] File changed:
New file
2017-09-25 03:35:09,868 [salt.state       ][INFO    ][25986] Completed state [/etc/keepalived/keepalived.conf] at time 03:35:09.867537 duration_in_ms=91.624
2017-09-25 03:35:09,964 [salt.state       ][INFO    ][25986] Running state [keepalived] at time 03:35:09.964214
2017-09-25 03:35:09,965 [salt.state       ][INFO    ][25986] Executing state service.running for keepalived
2017-09-25 03:35:09,967 [salt.loaded.int.module.cmdmod][INFO    ][25986] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-25 03:35:09,984 [salt.loaded.int.module.cmdmod][INFO    ][25986] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-25 03:35:09,998 [salt.loaded.int.module.cmdmod][INFO    ][25986] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-25 03:35:10,013 [salt.loaded.int.module.cmdmod][INFO    ][25986] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-25 03:35:10,029 [salt.loaded.int.module.cmdmod][INFO    ][25986] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-25 03:35:10,109 [salt.loaded.int.module.cmdmod][INFO    ][25986] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-25 03:35:10,123 [salt.loaded.int.module.cmdmod][INFO    ][25986] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-25 03:35:10,136 [salt.loaded.int.module.cmdmod][INFO    ][25986] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-25 03:35:10,146 [salt.state       ][INFO    ][25986] {'keepalived': True}
2017-09-25 03:35:10,146 [salt.state       ][INFO    ][25986] Completed state [keepalived] at time 03:35:10.145979 duration_in_ms=181.765
2017-09-25 03:35:10,147 [salt.minion      ][INFO    ][25986] Returning information for job: 20170925033456208858
2017-09-25 03:38:11,191 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command pillar.get with jid 20170925033811178280
2017-09-25 03:38:11,213 [salt.minion      ][INFO    ][27582] Starting a new job with PID 27582
2017-09-25 03:38:11,220 [salt.minion      ][INFO    ][27582] Returning information for job: 20170925033811178280
2017-09-25 03:44:09,165 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command state.sls with jid 20170925034409153556
2017-09-25 03:44:09,187 [salt.minion      ][INFO    ][27693] Starting a new job with PID 27693
2017-09-25 03:44:11,698 [salt.state       ][INFO    ][27693] Loading fresh modules for state activity
2017-09-25 03:44:11,738 [salt.fileclient  ][INFO    ][27693] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-25 03:44:11,773 [salt.fileclient  ][INFO    ][27693] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-25 03:44:12,173 [salt.state       ][INFO    ][27693] Running state [attr] at time 03:44:12.172654
2017-09-25 03:44:12,173 [salt.state       ][INFO    ][27693] Executing state pkg.installed for attr
2017-09-25 03:44:12,173 [salt.loaded.int.module.cmdmod][INFO    ][27693] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:44:12,585 [salt.loaded.int.module.cmdmod][INFO    ][27693] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-25 03:44:14,947 [salt.loaded.int.module.cmdmod][INFO    ][27693] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-09-25 03:44:18,090 [salt.loaded.int.module.cmdmod][INFO    ][27693] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:44:18,145 [salt.state       ][INFO    ][27693] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-25 03:44:18,163 [salt.state       ][INFO    ][27693] Loading fresh modules for state activity
2017-09-25 03:44:18,188 [salt.state       ][INFO    ][27693] Completed state [attr] at time 03:44:18.188191 duration_in_ms=6015.535
2017-09-25 03:44:18,198 [salt.state       ][INFO    ][27693] Running state [glusterfs-server] at time 03:44:18.197456
2017-09-25 03:44:18,198 [salt.state       ][INFO    ][27693] Executing state pkg.installed for glusterfs-server
2017-09-25 03:44:18,471 [salt.loaded.int.module.cmdmod][INFO    ][27693] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-09-25 03:44:19,262 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925034419248438
2017-09-25 03:44:19,283 [salt.minion      ][INFO    ][28687] Starting a new job with PID 28687
2017-09-25 03:44:19,304 [salt.minion      ][INFO    ][28687] Returning information for job: 20170925034419248438
2017-09-25 03:44:29,470 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925034429456553
2017-09-25 03:44:29,492 [salt.minion      ][INFO    ][31397] Starting a new job with PID 31397
2017-09-25 03:44:29,511 [salt.minion      ][INFO    ][31397] Returning information for job: 20170925034429456553
2017-09-25 03:44:39,528 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925034439503793
2017-09-25 03:44:39,548 [salt.minion      ][INFO    ][31990] Starting a new job with PID 31990
2017-09-25 03:44:39,567 [salt.minion      ][INFO    ][31990] Returning information for job: 20170925034439503793
2017-09-25 03:44:39,863 [salt.loaded.int.module.cmdmod][INFO    ][27693] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:44:39,920 [salt.state       ][INFO    ][27693] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-09-25 03:44:39,937 [salt.state       ][INFO    ][27693] Loading fresh modules for state activity
2017-09-25 03:44:39,965 [salt.state       ][INFO    ][27693] Completed state [glusterfs-server] at time 03:44:39.964537 duration_in_ms=21767.08
2017-09-25 03:44:39,973 [salt.state       ][INFO    ][27693] Running state [bc] at time 03:44:39.973241
2017-09-25 03:44:39,974 [salt.state       ][INFO    ][27693] Executing state pkg.installed for bc
2017-09-25 03:44:40,279 [salt.loaded.int.module.cmdmod][INFO    ][27693] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-09-25 03:44:43,843 [salt.loaded.int.module.cmdmod][INFO    ][27693] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:44:43,901 [salt.state       ][INFO    ][27693] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-25 03:44:43,916 [salt.state       ][INFO    ][27693] Loading fresh modules for state activity
2017-09-25 03:44:43,940 [salt.state       ][INFO    ][27693] Completed state [bc] at time 03:44:43.939984 duration_in_ms=3966.742
2017-09-25 03:44:44,035 [salt.state       ][INFO    ][27693] Running state [glusterfs-server] at time 03:44:44.034664
2017-09-25 03:44:44,035 [salt.state       ][INFO    ][27693] Executing state service.running for glusterfs-server
2017-09-25 03:44:44,037 [salt.loaded.int.module.cmdmod][INFO    ][27693] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-25 03:44:44,054 [salt.loaded.int.module.cmdmod][INFO    ][27693] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-25 03:44:44,069 [salt.loaded.int.module.cmdmod][INFO    ][27693] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-25 03:44:44,088 [salt.state       ][INFO    ][27693] The service glusterfs-server is already running
2017-09-25 03:44:44,089 [salt.state       ][INFO    ][27693] Completed state [glusterfs-server] at time 03:44:44.088422 duration_in_ms=53.758
2017-09-25 03:44:44,091 [salt.state       ][INFO    ][27693] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:44:44.090600
2017-09-25 03:44:44,091 [salt.state       ][INFO    ][27693] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-25 03:44:44,102 [salt.state       ][INFO    ][27693] File changed:
New file
2017-09-25 03:44:44,103 [salt.state       ][INFO    ][27693] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:44:44.102624 duration_in_ms=12.025
2017-09-25 03:44:44,103 [salt.state       ][INFO    ][27693] Running state [/srv/glusterfs/glance] at time 03:44:44.102899
2017-09-25 03:44:44,103 [salt.state       ][INFO    ][27693] Executing state file.directory for /srv/glusterfs/glance
2017-09-25 03:44:44,104 [salt.state       ][INFO    ][27693] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-25 03:44:44,104 [salt.state       ][INFO    ][27693] Completed state [/srv/glusterfs/glance] at time 03:44:44.104199 duration_in_ms=1.3
2017-09-25 03:44:44,104 [salt.state       ][INFO    ][27693] Running state [/srv/glusterfs/keystone-keys] at time 03:44:44.104446
2017-09-25 03:44:44,105 [salt.state       ][INFO    ][27693] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-25 03:44:44,105 [salt.state       ][INFO    ][27693] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-25 03:44:44,105 [salt.state       ][INFO    ][27693] Completed state [/srv/glusterfs/keystone-keys] at time 03:44:44.105447 duration_in_ms=1.001
2017-09-25 03:44:44,106 [salt.state       ][INFO    ][27693] Running state [/srv/glusterfs/nova_instances] at time 03:44:44.105703
2017-09-25 03:44:44,106 [salt.state       ][INFO    ][27693] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-25 03:44:44,107 [salt.state       ][INFO    ][27693] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-25 03:44:44,107 [salt.state       ][INFO    ][27693] Completed state [/srv/glusterfs/nova_instances] at time 03:44:44.106699 duration_in_ms=0.996
2017-09-25 03:44:44,107 [salt.state       ][INFO    ][27693] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:44:44.106946
2017-09-25 03:44:44,107 [salt.state       ][INFO    ][27693] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-25 03:44:44,108 [salt.state       ][INFO    ][27693] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-25 03:44:44,108 [salt.state       ][INFO    ][27693] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:44:44.107961 duration_in_ms=1.015
2017-09-25 03:44:44,109 [salt.minion      ][INFO    ][27693] Returning information for job: 20170925034409153556
2017-09-25 03:44:45,480 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command test.ping with jid 20170925034445465654
2017-09-25 03:44:45,502 [salt.minion      ][INFO    ][32435] Starting a new job with PID 32435
2017-09-25 03:44:45,554 [salt.minion      ][INFO    ][32435] Returning information for job: 20170925034445465654
2017-09-25 03:45:31,683 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command state.sls with jid 20170925034531670455
2017-09-25 03:45:31,704 [salt.minion      ][INFO    ][32653] Starting a new job with PID 32653
2017-09-25 03:45:32,125 [salt.state       ][INFO    ][32653] Loading fresh modules for state activity
2017-09-25 03:45:32,166 [salt.fileclient  ][INFO    ][32653] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-25 03:45:32,218 [salt.fileclient  ][INFO    ][32653] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-25 03:45:32,315 [salt.fileclient  ][INFO    ][32653] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-25 03:45:32,336 [salt.fileclient  ][INFO    ][32653] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-25 03:45:32,624 [salt.state       ][INFO    ][32653] Running state [attr] at time 03:45:32.624085
2017-09-25 03:45:32,624 [salt.state       ][INFO    ][32653] Executing state pkg.installed for attr
2017-09-25 03:45:32,625 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:45:33,044 [salt.state       ][INFO    ][32653] Package attr is already installed
2017-09-25 03:45:33,044 [salt.state       ][INFO    ][32653] Completed state [attr] at time 03:45:33.044015 duration_in_ms=419.931
2017-09-25 03:45:33,044 [salt.state       ][INFO    ][32653] Running state [glusterfs-server] at time 03:45:33.044287
2017-09-25 03:45:33,045 [salt.state       ][INFO    ][32653] Executing state pkg.installed for glusterfs-server
2017-09-25 03:45:33,048 [salt.state       ][INFO    ][32653] Package glusterfs-server is already installed
2017-09-25 03:45:33,048 [salt.state       ][INFO    ][32653] Completed state [glusterfs-server] at time 03:45:33.047994 duration_in_ms=3.706
2017-09-25 03:45:33,048 [salt.state       ][INFO    ][32653] Running state [bc] at time 03:45:33.048179
2017-09-25 03:45:33,048 [salt.state       ][INFO    ][32653] Executing state pkg.installed for bc
2017-09-25 03:45:33,052 [salt.state       ][INFO    ][32653] Package bc is already installed
2017-09-25 03:45:33,052 [salt.state       ][INFO    ][32653] Completed state [bc] at time 03:45:33.051655 duration_in_ms=3.475
2017-09-25 03:45:33,053 [salt.state       ][INFO    ][32653] Running state [glusterfs-server] at time 03:45:33.052623
2017-09-25 03:45:33,053 [salt.state       ][INFO    ][32653] Executing state service.running for glusterfs-server
2017-09-25 03:45:33,053 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-25 03:45:33,069 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-25 03:45:33,149 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-25 03:45:33,177 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-25 03:45:33,189 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-25 03:45:33,205 [salt.state       ][INFO    ][32653] The service glusterfs-server is already running
2017-09-25 03:45:33,205 [salt.state       ][INFO    ][32653] Completed state [glusterfs-server] at time 03:45:33.205246 duration_in_ms=152.621
2017-09-25 03:45:33,208 [salt.state       ][INFO    ][32653] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:45:33.208156
2017-09-25 03:45:33,209 [salt.state       ][INFO    ][32653] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-25 03:45:33,223 [salt.state       ][INFO    ][32653] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-25 03:45:33,224 [salt.state       ][INFO    ][32653] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:45:33.223710 duration_in_ms=15.554
2017-09-25 03:45:33,224 [salt.state       ][INFO    ][32653] Running state [/srv/glusterfs/glance] at time 03:45:33.224054
2017-09-25 03:45:33,224 [salt.state       ][INFO    ][32653] Executing state file.directory for /srv/glusterfs/glance
2017-09-25 03:45:33,225 [salt.state       ][INFO    ][32653] Directory /srv/glusterfs/glance is in the correct state
2017-09-25 03:45:33,225 [salt.state       ][INFO    ][32653] Completed state [/srv/glusterfs/glance] at time 03:45:33.225362 duration_in_ms=1.307
2017-09-25 03:45:33,226 [salt.state       ][INFO    ][32653] Running state [/srv/glusterfs/keystone-keys] at time 03:45:33.225689
2017-09-25 03:45:33,226 [salt.state       ][INFO    ][32653] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-25 03:45:33,227 [salt.state       ][INFO    ][32653] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-25 03:45:33,227 [salt.state       ][INFO    ][32653] Completed state [/srv/glusterfs/keystone-keys] at time 03:45:33.226971 duration_in_ms=1.281
2017-09-25 03:45:33,227 [salt.state       ][INFO    ][32653] Running state [/srv/glusterfs/nova_instances] at time 03:45:33.227296
2017-09-25 03:45:33,228 [salt.state       ][INFO    ][32653] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-25 03:45:33,228 [salt.state       ][INFO    ][32653] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-25 03:45:33,229 [salt.state       ][INFO    ][32653] Completed state [/srv/glusterfs/nova_instances] at time 03:45:33.228663 duration_in_ms=1.367
2017-09-25 03:45:33,229 [salt.state       ][INFO    ][32653] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:45:33.228995
2017-09-25 03:45:33,229 [salt.state       ][INFO    ][32653] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-25 03:45:33,230 [salt.state       ][INFO    ][32653] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-25 03:45:33,230 [salt.state       ][INFO    ][32653] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:45:33.230264 duration_in_ms=1.27
2017-09-25 03:45:33,343 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command ['git', '--version'] in directory '/root'
2017-09-25 03:45:33,483 [salt.state       ][INFO    ][32653] Running state [sleep 5] at time 03:45:33.483242
2017-09-25 03:45:33,484 [salt.state       ][INFO    ][32653] Executing state cmd.wait for sleep 5
2017-09-25 03:45:33,484 [salt.state       ][INFO    ][32653] No changes made for sleep 5
2017-09-25 03:45:33,484 [salt.state       ][INFO    ][32653] Completed state [sleep 5] at time 03:45:33.483906 duration_in_ms=0.665
2017-09-25 03:45:33,484 [salt.state       ][INFO    ][32653] Running state [10.167.4.141] at time 03:45:33.484304
2017-09-25 03:45:33,484 [salt.state       ][INFO    ][32653] Executing state glusterfs.peered for 10.167.4.141
2017-09-25 03:45:33,485 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:33,503 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:33,611 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:33,627 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:33,736 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:33,751 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:33,852 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:33,870 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:33,976 [salt.state       ][INFO    ][32653] Peering with localhost is not needed
2017-09-25 03:45:33,977 [salt.state       ][INFO    ][32653] Completed state [10.167.4.141] at time 03:45:33.976515 duration_in_ms=492.209
2017-09-25 03:45:33,982 [salt.state       ][INFO    ][32653] Running state [10.167.4.142] at time 03:45:33.982291
2017-09-25 03:45:33,983 [salt.state       ][INFO    ][32653] Executing state glusterfs.peered for 10.167.4.142
2017-09-25 03:45:33,984 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:34,000 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:34,106 [salt.state       ][INFO    ][32653] Host 10.167.4.142 already peered
2017-09-25 03:45:34,107 [salt.state       ][INFO    ][32653] Completed state [10.167.4.142] at time 03:45:34.107080 duration_in_ms=124.787
2017-09-25 03:45:34,113 [salt.state       ][INFO    ][32653] Running state [10.167.4.143] at time 03:45:34.113280
2017-09-25 03:45:34,114 [salt.state       ][INFO    ][32653] Executing state glusterfs.peered for 10.167.4.143
2017-09-25 03:45:34,115 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:34,131 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:34,239 [salt.state       ][INFO    ][32653] Host 10.167.4.143 already peered
2017-09-25 03:45:34,239 [salt.state       ][INFO    ][32653] Completed state [10.167.4.143] at time 03:45:34.239085 duration_in_ms=125.804
2017-09-25 03:45:34,241 [salt.state       ][INFO    ][32653] Running state [glance] at time 03:45:34.241052
2017-09-25 03:45:34,242 [salt.state       ][INFO    ][32653] Executing state glusterfs.created for glance
2017-09-25 03:45:34,243 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:34,260 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:34,360 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:34,377 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:34,491 [salt.state       ][INFO    ][32653] Volume glance already exists and is started.
2017-09-25 03:45:34,491 [salt.state       ][INFO    ][32653] Completed state [glance] at time 03:45:34.491035 duration_in_ms=249.981
2017-09-25 03:45:34,498 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:34.498266
2017-09-25 03:45:34,499 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-25 03:45:34,500 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:34,607 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:34,607 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:34.607306 duration_in_ms=109.039
2017-09-25 03:45:34,609 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:45:34.608431
2017-09-25 03:45:34,609 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-25 03:45:34,610 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-25 03:45:34,713 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:34,714 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:45:34.713933 duration_in_ms=105.501
2017-09-25 03:45:34,715 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:45:34.715093
2017-09-25 03:45:34,716 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-25 03:45:34,717 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-25 03:45:34,824 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:34,824 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:45:34.824115 duration_in_ms=109.021
2017-09-25 03:45:34,825 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:34.825206
2017-09-25 03:45:34,826 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-25 03:45:34,827 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:34,931 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:34,945 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:34.944526 duration_in_ms=119.319
2017-09-25 03:45:34,946 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:45:34.945622
2017-09-25 03:45:34,946 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-25 03:45:34,947 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-25 03:45:35,046 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:35,046 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:45:35.046359 duration_in_ms=100.736
2017-09-25 03:45:35,049 [salt.state       ][INFO    ][32653] Running state [glance] at time 03:45:35.048897
2017-09-25 03:45:35,049 [salt.state       ][INFO    ][32653] Executing state glusterfs.started for glance
2017-09-25 03:45:35,050 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:35,065 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:35,169 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:35,184 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:35,297 [salt.state       ][INFO    ][32653] Volume glance is already started
2017-09-25 03:45:35,297 [salt.state       ][INFO    ][32653] Completed state [glance] at time 03:45:35.297280 duration_in_ms=248.382
2017-09-25 03:45:35,299 [salt.state       ][INFO    ][32653] Running state [keystone-keys] at time 03:45:35.299292
2017-09-25 03:45:35,300 [salt.state       ][INFO    ][32653] Executing state glusterfs.created for keystone-keys
2017-09-25 03:45:35,301 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:35,318 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:35,428 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:35,445 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:35,556 [salt.state       ][INFO    ][32653] Volume keystone-keys already exists and is started.
2017-09-25 03:45:35,557 [salt.state       ][INFO    ][32653] Completed state [keystone-keys] at time 03:45:35.556784 duration_in_ms=257.491
2017-09-25 03:45:35,565 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:45:35.565093
2017-09-25 03:45:35,566 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-25 03:45:35,567 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-25 03:45:35,677 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:35,677 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:45:35.677249 duration_in_ms=112.156
2017-09-25 03:45:35,678 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:35.678326
2017-09-25 03:45:35,679 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-25 03:45:35,680 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:35,781 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:35,782 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:35.781889 duration_in_ms=103.561
2017-09-25 03:45:35,783 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:35.782983
2017-09-25 03:45:35,784 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-25 03:45:35,785 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:35,889 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:35,890 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:35.889577 duration_in_ms=106.594
2017-09-25 03:45:35,891 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:45:35.890595
2017-09-25 03:45:35,891 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-25 03:45:35,892 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-25 03:45:35,994 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:35,995 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:45:35.994595 duration_in_ms=103.999
2017-09-25 03:45:35,996 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:45:35.995726
2017-09-25 03:45:35,996 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-25 03:45:35,997 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-25 03:45:36,104 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:36,105 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:45:36.104919 duration_in_ms=109.192
2017-09-25 03:45:36,108 [salt.state       ][INFO    ][32653] Running state [keystone-keys] at time 03:45:36.107436
2017-09-25 03:45:36,108 [salt.state       ][INFO    ][32653] Executing state glusterfs.started for keystone-keys
2017-09-25 03:45:36,109 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:36,125 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:36,229 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:36,246 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:36,365 [salt.state       ][INFO    ][32653] Volume keystone-keys is already started
2017-09-25 03:45:36,365 [salt.state       ][INFO    ][32653] Completed state [keystone-keys] at time 03:45:36.365313 duration_in_ms=257.876
2017-09-25 03:45:36,367 [salt.state       ][INFO    ][32653] Running state [nova_instances] at time 03:45:36.367409
2017-09-25 03:45:36,368 [salt.state       ][INFO    ][32653] Executing state glusterfs.created for nova_instances
2017-09-25 03:45:36,369 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:36,387 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:36,494 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:36,512 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:36,621 [salt.state       ][INFO    ][32653] Volume nova_instances already exists and is started.
2017-09-25 03:45:36,622 [salt.state       ][INFO    ][32653] Completed state [nova_instances] at time 03:45:36.621600 duration_in_ms=254.189
2017-09-25 03:45:36,629 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:36.629032
2017-09-25 03:45:36,630 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-25 03:45:36,631 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:36,737 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:36,738 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:36.737632 duration_in_ms=108.599
2017-09-25 03:45:36,739 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 03:45:36.738744
2017-09-25 03:45:36,739 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-09-25 03:45:36,740 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-25 03:45:36,851 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:36,852 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 03:45:36.851951 duration_in_ms=113.206
2017-09-25 03:45:36,853 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 03:45:36.853031
2017-09-25 03:45:36,854 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-09-25 03:45:36,855 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-25 03:45:36,961 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:36,961 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 03:45:36.961334 duration_in_ms=108.302
2017-09-25 03:45:36,962 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 03:45:36.962425
2017-09-25 03:45:36,963 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-09-25 03:45:36,964 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-09-25 03:45:37,074 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:37,074 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 03:45:37.074064 duration_in_ms=111.638
2017-09-25 03:45:37,075 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:37.075169
2017-09-25 03:45:37,076 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-25 03:45:37,077 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:37,181 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:37,181 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:37.181088 duration_in_ms=105.919
2017-09-25 03:45:37,184 [salt.state       ][INFO    ][32653] Running state [nova_instances] at time 03:45:37.183641
2017-09-25 03:45:37,184 [salt.state       ][INFO    ][32653] Executing state glusterfs.started for nova_instances
2017-09-25 03:45:37,185 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:37,202 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:37,310 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:37,325 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:37,440 [salt.state       ][INFO    ][32653] Volume nova_instances is already started
2017-09-25 03:45:37,440 [salt.state       ][INFO    ][32653] Completed state [nova_instances] at time 03:45:37.440313 duration_in_ms=256.671
2017-09-25 03:45:37,442 [salt.state       ][INFO    ][32653] Running state [keystone-credential-keys] at time 03:45:37.442349
2017-09-25 03:45:37,443 [salt.state       ][INFO    ][32653] Executing state glusterfs.created for keystone-credential-keys
2017-09-25 03:45:37,444 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:37,460 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:37,565 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:37,582 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:37,695 [salt.state       ][INFO    ][32653] Volume keystone-credential-keys already exists and is started.
2017-09-25 03:45:37,696 [salt.state       ][INFO    ][32653] Completed state [keystone-credential-keys] at time 03:45:37.695900 duration_in_ms=253.55
2017-09-25 03:45:37,704 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:45:37.704186
2017-09-25 03:45:37,705 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-25 03:45:37,706 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-25 03:45:37,817 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:37,818 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:45:37.817747 duration_in_ms=113.56
2017-09-25 03:45:37,819 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:37.818743
2017-09-25 03:45:37,819 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-25 03:45:37,820 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:37,916 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:37,916 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:37.916075 duration_in_ms=97.331
2017-09-25 03:45:37,917 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:45:37.917156
2017-09-25 03:45:37,918 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-25 03:45:37,919 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-25 03:45:38,029 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:38,029 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:45:38.029242 duration_in_ms=112.084
2017-09-25 03:45:38,030 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:38.030340
2017-09-25 03:45:38,031 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-25 03:45:38,032 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:38,133 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:38,133 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:38.133107 duration_in_ms=102.767
2017-09-25 03:45:38,134 [salt.state       ][INFO    ][32653] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:45:38.134232
2017-09-25 03:45:38,135 [salt.state       ][INFO    ][32653] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-25 03:45:38,136 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-25 03:45:38,244 [salt.state       ][INFO    ][32653] unless execution succeeded
2017-09-25 03:45:38,244 [salt.state       ][INFO    ][32653] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:45:38.244363 duration_in_ms=110.13
2017-09-25 03:45:38,247 [salt.state       ][INFO    ][32653] Running state [keystone-credential-keys] at time 03:45:38.246548
2017-09-25 03:45:38,247 [salt.state       ][INFO    ][32653] Executing state glusterfs.started for keystone-credential-keys
2017-09-25 03:45:38,248 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:38,262 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:38,370 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:38,388 [salt.loaded.int.module.cmdmod][INFO    ][32653] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:38,500 [salt.state       ][INFO    ][32653] Volume keystone-credential-keys is already started
2017-09-25 03:45:38,501 [salt.state       ][INFO    ][32653] Completed state [keystone-credential-keys] at time 03:45:38.500442 duration_in_ms=253.894
2017-09-25 03:45:38,504 [salt.minion      ][INFO    ][32653] Returning information for job: 20170925034531670455
2017-09-25 03:45:39,846 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command test.ping with jid 20170925034539833722
2017-09-25 03:45:39,868 [salt.minion      ][INFO    ][588] Starting a new job with PID 588
2017-09-25 03:45:39,922 [salt.minion      ][INFO    ][588] Returning information for job: 20170925034539833722
2017-09-25 03:45:40,562 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command cmd.run with jid 20170925034540551099
2017-09-25 03:45:40,585 [salt.minion      ][INFO    ][593] Starting a new job with PID 593
2017-09-25 03:45:40,592 [salt.loaded.int.module.cmdmod][INFO    ][593] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-25 03:45:40,810 [salt.minion      ][INFO    ][593] Returning information for job: 20170925034540551099
2017-09-25 04:05:55,659 [salt.utils.schedule][INFO    ][24229] Running scheduled job: __mine_interval
2017-09-25 05:01:10,873 [salt.minion      ][INFO    ][24229] User sudo_ubuntu Executing command cp.push_dir with jid 20170925050110860852
2017-09-25 05:01:10,896 [salt.minion      ][INFO    ][1794] Starting a new job with PID 1794
