2017-09-18 09:42:28,747 [salt.cli.daemons ][WARNING ][2530] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-18 09:42:42,787 [salt.state       ][ERROR   ][3780] No contents found in top file
2017-09-18 09:43:00,293 [salt.utils.parsers][WARNING ][2530] Minion received a SIGTERM. Exiting.
2017-09-18 09:45:22,660 [salt.cli.daemons ][WARNING ][3217] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-18 09:50:04,632 [py.warnings      ][WARNING ][16436] /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-18 09:53:15,228 [salt.loaded.int.module.cmdmod][ERROR   ][16436] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 09:53:15,229 [salt.loaded.int.module.cmdmod][ERROR   ][16436] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 09:53:22,923 [salt.loaded.int.module.cmdmod][ERROR   ][16436] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 09:53:22,923 [salt.loaded.int.module.cmdmod][ERROR   ][16436] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 09:53:32,137 [salt.loaded.int.module.cmdmod][ERROR   ][16436] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 09:53:32,138 [salt.loaded.int.module.cmdmod][ERROR   ][16436] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 09:53:42,465 [salt.loaded.int.module.cmdmod][ERROR   ][16436] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 09:53:42,466 [salt.loaded.int.module.cmdmod][ERROR   ][16436] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 09:53:52,501 [salt.loaded.int.module.cmdmod][ERROR   ][16436] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 09:53:52,501 [salt.loaded.int.module.cmdmod][ERROR   ][16436] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 09:53:59,936 [salt.loaded.int.module.cmdmod][ERROR   ][16436] 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-18 09:54:03,373 [salt.state       ][ERROR   ][24132] No contents found in top file
2017-09-18 09:54:07,977 [salt.loaded.int.module.cmdmod][INFO    ][24383] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-18 09:54:07,990 [salt.loaded.int.module.cmdmod][INFO    ][24383] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-18 09:54:08,011 [salt.loaded.int.module.cmdmod][INFO    ][24383] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-18 09:54:08,027 [salt.utils.parsers][WARNING ][3217] Minion received a SIGTERM. Exiting.
2017-09-18 09:54:08,483 [salt.cli.daemons ][INFO    ][24490] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-09-18 09:54:09,258 [salt.minion      ][INFO    ][24490] Creating minion process manager
2017-09-18 09:54:09,259 [salt.cli.daemons ][WARNING ][24490] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-18 09:54:09,259 [salt.cli.daemons ][INFO    ][24490] The Salt Minion is starting up
2017-09-18 09:54:09,259 [salt.minion      ][INFO    ][24490] Minion is starting as user 'root'
2017-09-18 09:54:09,259 [salt.utils.event ][INFO    ][24490] Starting pull socket on /var/run/salt/minion/minion_event_0031115955_pull.ipc
2017-09-18 09:54:10,409 [salt.loaded.int.module.cmdmod][INFO    ][24490] Executing command ['date', '+%z'] in directory '/root'
2017-09-18 09:54:10,434 [salt.utils.schedule][INFO    ][24490] Updating job settings for scheduled job: __mine_interval
2017-09-18 09:54:10,440 [salt.minion      ][INFO    ][24490] Added mine.update to scheduler
2017-09-18 09:54:10,764 [salt.minion      ][INFO    ][24490] Minion is ready to receive requests!
2017-09-18 09:54:11,766 [salt.utils.schedule][INFO    ][24490] Running scheduled job: __mine_interval
2017-09-18 09:54:12,188 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command state.sls with jid 20170918095412184083
2017-09-18 09:54:12,209 [salt.minion      ][INFO    ][24590] Starting a new job with PID 24590
2017-09-18 09:54:12,681 [salt.state       ][INFO    ][24590] Loading fresh modules for state activity
2017-09-18 09:54:12,722 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-18 09:54:12,781 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-18 09:54:12,823 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 09:54:12,943 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-18 09:54:12,963 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-18 09:54:13,027 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 09:54:13,190 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-18 09:54:13,208 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-18 09:54:13,251 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-18 09:54:13,271 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-18 09:54:13,283 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-18 09:54:13,299 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-18 09:54:13,316 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-18 09:54:13,393 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-18 09:54:13,426 [py.warnings      ][WARNING ][24590] /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-18 09:54:13,426 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'salt-minion --version' in directory '/root'
2017-09-18 09:54:13,785 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-18 09:54:13,808 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-18 09:54:13,845 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-18 09:54:13,862 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-18 09:54:13,942 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-18 09:54:13,993 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-18 09:54:14,085 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-18 09:54:14,112 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 09:54:14,210 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-18 09:54:14,236 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-18 09:54:14,296 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-18 09:54:14,320 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-18 09:54:14,343 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-18 09:54:14,385 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-18 09:54:14,403 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-18 09:54:14,440 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-18 09:54:14,474 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'salt-minion --version' in directory '/root'
2017-09-18 09:54:14,857 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-18 09:54:14,881 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-18 09:54:14,897 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-18 09:54:14,914 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-18 09:54:14,991 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-18 09:54:15,042 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-18 09:54:15,133 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-18 09:54:15,202 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 09:54:15,539 [salt.state       ][INFO    ][24590] Running state [salt-minion] at time 09:54:15.539346
2017-09-18 09:54:15,540 [salt.state       ][INFO    ][24590] Executing state pkg.installed for salt-minion
2017-09-18 09:54:15,540 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 09:54:15,991 [salt.state       ][INFO    ][24590] Package salt-minion is already installed
2017-09-18 09:54:15,991 [salt.state       ][INFO    ][24590] Completed state [salt-minion] at time 09:54:15.991212 duration_in_ms=451.866
2017-09-18 09:54:15,992 [salt.state       ][INFO    ][24590] Running state [python-yaml] at time 09:54:15.991480
2017-09-18 09:54:15,992 [salt.state       ][INFO    ][24590] Executing state pkg.installed for python-yaml
2017-09-18 09:54:15,995 [salt.state       ][INFO    ][24590] Package python-yaml is already installed
2017-09-18 09:54:15,995 [salt.state       ][INFO    ][24590] Completed state [python-yaml] at time 09:54:15.995382 duration_in_ms=3.902
2017-09-18 09:54:15,996 [salt.state       ][INFO    ][24590] Running state [python-psutil] at time 09:54:15.995598
2017-09-18 09:54:15,996 [salt.state       ][INFO    ][24590] Executing state pkg.installed for python-psutil
2017-09-18 09:54:15,999 [salt.state       ][INFO    ][24590] Package python-psutil is already installed
2017-09-18 09:54:15,999 [salt.state       ][INFO    ][24590] Completed state [python-psutil] at time 09:54:15.999295 duration_in_ms=3.697
2017-09-18 09:54:15,1000 [salt.state       ][INFO    ][24590] Running state [python-m2crypto] at time 09:54:15.999500
2017-09-18 09:54:15,1000 [salt.state       ][INFO    ][24590] Executing state pkg.installed for python-m2crypto
2017-09-18 09:54:16,003 [salt.state       ][INFO    ][24590] Package python-m2crypto is already installed
2017-09-18 09:54:16,003 [salt.state       ][INFO    ][24590] Completed state [python-m2crypto] at time 09:54:16.003151 duration_in_ms=3.651
2017-09-18 09:54:16,005 [salt.state       ][INFO    ][24590] Running state [/etc/salt/minion.d/minion.conf] at time 09:54:16.004961
2017-09-18 09:54:16,005 [salt.state       ][INFO    ][24590] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-18 09:54:16,045 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-18 09:54:16,129 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 09:54:16,195 [salt.fileclient  ][INFO    ][24590] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-18 09:54:16,245 [salt.state       ][INFO    ][24590] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-18 09:54:16,246 [salt.state       ][INFO    ][24590] Completed state [/etc/salt/minion.d/minion.conf] at time 09:54:16.245427 duration_in_ms=240.463
2017-09-18 09:54:16,246 [salt.state       ][INFO    ][24590] Running state [/etc/salt/minion.d/_virt.conf] at time 09:54:16.246291
2017-09-18 09:54:16,247 [salt.state       ][INFO    ][24590] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-18 09:54:16,271 [salt.state       ][INFO    ][24590] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-18 09:54:16,272 [salt.state       ][INFO    ][24590] Completed state [/etc/salt/minion.d/_virt.conf] at time 09:54:16.271436 duration_in_ms=25.144
2017-09-18 09:54:16,274 [salt.state       ][INFO    ][24590] Running state [salt-minion] at time 09:54:16.273973
2017-09-18 09:54:16,274 [salt.state       ][INFO    ][24590] Executing state service.running for salt-minion
2017-09-18 09:54:16,275 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-18 09:54:16,307 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-18 09:54:16,343 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-18 09:54:16,357 [salt.state       ][INFO    ][24590] The service salt-minion is already running
2017-09-18 09:54:16,371 [salt.state       ][INFO    ][24590] Completed state [salt-minion] at time 09:54:16.371199 duration_in_ms=97.225
2017-09-18 09:54:16,374 [salt.state       ][INFO    ][24590] Running state [/etc/salt/grains.d] at time 09:54:16.373689
2017-09-18 09:54:16,374 [salt.state       ][INFO    ][24590] Executing state file.directory for /etc/salt/grains.d
2017-09-18 09:54:16,375 [salt.state       ][INFO    ][24590] Directory /etc/salt/grains.d is in the correct state
2017-09-18 09:54:16,376 [salt.state       ][INFO    ][24590] Completed state [/etc/salt/grains.d] at time 09:54:16.375608 duration_in_ms=1.919
2017-09-18 09:54:16,377 [salt.state       ][INFO    ][24590] Running state [/etc/salt/grains] at time 09:54:16.376580
2017-09-18 09:54:16,377 [salt.state       ][INFO    ][24590] Executing state file.managed for /etc/salt/grains
2017-09-18 09:54:16,390 [salt.state       ][INFO    ][24590] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-18 09:54:16,390 [salt.state       ][INFO    ][24590] Completed state [/etc/salt/grains] at time 09:54:16.390162 duration_in_ms=13.582
2017-09-18 09:54:16,391 [salt.state       ][INFO    ][24590] Running state [/etc/salt/grains.d/placeholder] at time 09:54:16.390906
2017-09-18 09:54:16,391 [salt.state       ][INFO    ][24590] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-18 09:54:16,392 [salt.state       ][INFO    ][24590] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-18 09:54:16,392 [salt.state       ][INFO    ][24590] Completed state [/etc/salt/grains.d/placeholder] at time 09:54:16.392404 duration_in_ms=1.497
2017-09-18 09:54:16,393 [salt.state       ][INFO    ][24590] Running state [/etc/salt/grains.d/sphinx] at time 09:54:16.393114
2017-09-18 09:54:16,394 [salt.state       ][INFO    ][24590] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-18 09:54:16,425 [salt.state       ][INFO    ][24590] File /etc/salt/grains.d/sphinx is in the correct state
2017-09-18 09:54:16,426 [salt.state       ][INFO    ][24590] Completed state [/etc/salt/grains.d/sphinx] at time 09:54:16.425464 duration_in_ms=32.349
2017-09-18 09:54:16,427 [salt.state       ][INFO    ][24590] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:54:16.426639
2017-09-18 09:54:16,427 [salt.state       ][INFO    ][24590] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-18 09:54:16,428 [salt.state       ][INFO    ][24590] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-18 09:54:16,428 [salt.state       ][INFO    ][24590] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:54:16.427836 duration_in_ms=1.197
2017-09-18 09:54:16,429 [salt.state       ][INFO    ][24590] Running state [/etc/salt/grains.d/dns_records] at time 09:54:16.428525
2017-09-18 09:54:16,429 [salt.state       ][INFO    ][24590] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-18 09:54:16,486 [salt.state       ][INFO    ][24590] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-18 09:54:16,486 [salt.state       ][INFO    ][24590] Completed state [/etc/salt/grains.d/dns_records] at time 09:54:16.485859 duration_in_ms=57.334
2017-09-18 09:54:16,487 [salt.state       ][INFO    ][24590] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:54:16.487078
2017-09-18 09:54:16,488 [salt.state       ][INFO    ][24590] 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-18 09:54:16,488 [salt.state       ][INFO    ][24590] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-18 09:54:16,488 [salt.state       ][INFO    ][24590] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:54:16.488351 duration_in_ms=1.273
2017-09-18 09:54:16,489 [salt.state       ][INFO    ][24590] Running state [/etc/salt/grains.d/salt] at time 09:54:16.489097
2017-09-18 09:54:16,490 [salt.state       ][INFO    ][24590] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-18 09:54:16,558 [salt.state       ][INFO    ][24590] File /etc/salt/grains.d/salt is in the correct state
2017-09-18 09:54:16,558 [salt.state       ][INFO    ][24590] Completed state [/etc/salt/grains.d/salt] at time 09:54:16.557869 duration_in_ms=68.772
2017-09-18 09:54:16,559 [salt.state       ][INFO    ][24590] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:54:16.558960
2017-09-18 09:54:16,559 [salt.state       ][INFO    ][24590] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-18 09:54:16,560 [salt.state       ][INFO    ][24590] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-18 09:54:16,560 [salt.state       ][INFO    ][24590] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:54:16.560138 duration_in_ms=1.178
2017-09-18 09:54:16,563 [salt.state       ][INFO    ][24590] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:54:16.563390
2017-09-18 09:54:16,570 [salt.state       ][INFO    ][24590] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-18 09:54:16,570 [salt.state       ][INFO    ][24590] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-18 09:54:16,571 [salt.state       ][INFO    ][24590] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:54:16.570435 duration_in_ms=7.045
2017-09-18 09:54:16,572 [salt.state       ][INFO    ][24590] Running state [mine.update] at time 09:54:16.571545
2017-09-18 09:54:16,572 [salt.state       ][INFO    ][24590] Executing state module.wait for mine.update
2017-09-18 09:54:16,572 [salt.state       ][INFO    ][24590] No changes made for mine.update
2017-09-18 09:54:16,573 [salt.state       ][INFO    ][24590] Completed state [mine.update] at time 09:54:16.572719 duration_in_ms=1.174
2017-09-18 09:54:16,573 [salt.state       ][INFO    ][24590] Running state [ca-certificates] at time 09:54:16.573095
2017-09-18 09:54:16,574 [salt.state       ][INFO    ][24590] Executing state pkg.installed for ca-certificates
2017-09-18 09:54:16,581 [salt.state       ][INFO    ][24590] Package ca-certificates is already installed
2017-09-18 09:54:16,582 [salt.state       ][INFO    ][24590] Completed state [ca-certificates] at time 09:54:16.581518 duration_in_ms=8.423
2017-09-18 09:54:16,583 [salt.state       ][INFO    ][24590] Running state [update-ca-certificates] at time 09:54:16.582581
2017-09-18 09:54:16,583 [salt.state       ][INFO    ][24590] Executing state cmd.wait for update-ca-certificates
2017-09-18 09:54:16,583 [salt.state       ][INFO    ][24590] No changes made for update-ca-certificates
2017-09-18 09:54:16,584 [salt.state       ][INFO    ][24590] Completed state [update-ca-certificates] at time 09:54:16.583734 duration_in_ms=1.153
2017-09-18 09:54:16,584 [salt.state       ][INFO    ][24590] Running state [libvirt-dev] at time 09:54:16.584087
2017-09-18 09:54:16,584 [salt.state       ][INFO    ][24590] Executing state pkg.installed for libvirt-dev
2017-09-18 09:54:16,591 [salt.state       ][INFO    ][24590] Package libvirt-dev is already installed
2017-09-18 09:54:16,591 [salt.state       ][INFO    ][24590] Completed state [libvirt-dev] at time 09:54:16.591329 duration_in_ms=7.242
2017-09-18 09:54:16,592 [salt.state       ][INFO    ][24590] Running state [pkg-config] at time 09:54:16.591671
2017-09-18 09:54:16,594 [salt.state       ][INFO    ][24590] Executing state pkg.installed for pkg-config
2017-09-18 09:54:16,601 [salt.state       ][INFO    ][24590] Package pkg-config is already installed
2017-09-18 09:54:16,601 [salt.state       ][INFO    ][24590] Completed state [pkg-config] at time 09:54:16.600777 duration_in_ms=9.105
2017-09-18 09:54:16,601 [salt.state       ][INFO    ][24590] Running state [virtng.init] at time 09:54:16.601168
2017-09-18 09:54:16,602 [salt.state       ][INFO    ][24590] Executing state module.run for virtng.init
2017-09-18 09:54:16,737 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command ['git', '--version'] in directory '/root'
2017-09-18 09:54:16,848 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-18 09:54:16,884 [salt.state       ][INFO    ][24590] unless execution succeeded
2017-09-18 09:54:16,885 [salt.state       ][INFO    ][24590] Completed state [virtng.init] at time 09:54:16.884875 duration_in_ms=283.705
2017-09-18 09:54:16,886 [salt.state       ][INFO    ][24590] Running state [virt.set_autostart] at time 09:54:16.885466
2017-09-18 09:54:16,886 [salt.state       ][INFO    ][24590] Executing state module.run for virt.set_autostart
2017-09-18 09:54:16,891 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-18 09:54:16,927 [salt.state       ][INFO    ][24590] unless execution succeeded
2017-09-18 09:54:16,930 [salt.state       ][INFO    ][24590] Completed state [virt.set_autostart] at time 09:54:16.930137 duration_in_ms=44.67
2017-09-18 09:54:16,931 [salt.state       ][INFO    ][24590] Running state [virtng.init] at time 09:54:16.930756
2017-09-18 09:54:16,931 [salt.state       ][INFO    ][24590] Executing state module.run for virtng.init
2017-09-18 09:54:16,937 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-18 09:54:16,972 [salt.state       ][INFO    ][24590] unless execution succeeded
2017-09-18 09:54:16,973 [salt.state       ][INFO    ][24590] Completed state [virtng.init] at time 09:54:16.972837 duration_in_ms=42.08
2017-09-18 09:54:16,973 [salt.state       ][INFO    ][24590] Running state [virt.set_autostart] at time 09:54:16.973314
2017-09-18 09:54:16,974 [salt.state       ][INFO    ][24590] Executing state module.run for virt.set_autostart
2017-09-18 09:54:16,979 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-18 09:54:17,011 [salt.state       ][INFO    ][24590] unless execution succeeded
2017-09-18 09:54:17,012 [salt.state       ][INFO    ][24590] Completed state [virt.set_autostart] at time 09:54:17.011444 duration_in_ms=38.129
2017-09-18 09:54:17,012 [salt.state       ][INFO    ][24590] Running state [virtng.init] at time 09:54:17.011962
2017-09-18 09:54:17,012 [salt.state       ][INFO    ][24590] Executing state module.run for virtng.init
2017-09-18 09:54:17,018 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-18 09:54:17,049 [salt.state       ][INFO    ][24590] unless execution succeeded
2017-09-18 09:54:17,049 [salt.state       ][INFO    ][24590] Completed state [virtng.init] at time 09:54:17.049023 duration_in_ms=37.061
2017-09-18 09:54:17,050 [salt.state       ][INFO    ][24590] Running state [virt.set_autostart] at time 09:54:17.049640
2017-09-18 09:54:17,050 [salt.state       ][INFO    ][24590] Executing state module.run for virt.set_autostart
2017-09-18 09:54:17,055 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-18 09:54:17,089 [salt.state       ][INFO    ][24590] unless execution succeeded
2017-09-18 09:54:17,090 [salt.state       ][INFO    ][24590] Completed state [virt.set_autostart] at time 09:54:17.089831 duration_in_ms=40.191
2017-09-18 09:54:17,090 [salt.state       ][INFO    ][24590] Running state [virtng.init] at time 09:54:17.090342
2017-09-18 09:54:17,098 [salt.state       ][INFO    ][24590] Executing state module.run for virtng.init
2017-09-18 09:54:17,103 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-18 09:54:17,135 [salt.state       ][INFO    ][24590] unless execution succeeded
2017-09-18 09:54:17,135 [salt.state       ][INFO    ][24590] Completed state [virtng.init] at time 09:54:17.135070 duration_in_ms=44.726
2017-09-18 09:54:17,136 [salt.state       ][INFO    ][24590] Running state [virt.set_autostart] at time 09:54:17.135607
2017-09-18 09:54:17,136 [salt.state       ][INFO    ][24590] Executing state module.run for virt.set_autostart
2017-09-18 09:54:17,141 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-18 09:54:17,192 [salt.state       ][INFO    ][24590] unless execution succeeded
2017-09-18 09:54:17,193 [salt.state       ][INFO    ][24590] Completed state [virt.set_autostart] at time 09:54:17.192808 duration_in_ms=57.2
2017-09-18 09:54:17,193 [salt.state       ][INFO    ][24590] Running state [virtng.init] at time 09:54:17.193382
2017-09-18 09:54:17,194 [salt.state       ][INFO    ][24590] Executing state module.run for virtng.init
2017-09-18 09:54:17,205 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-18 09:54:17,237 [salt.state       ][INFO    ][24590] unless execution succeeded
2017-09-18 09:54:17,237 [salt.state       ][INFO    ][24590] Completed state [virtng.init] at time 09:54:17.237203 duration_in_ms=43.819
2017-09-18 09:54:17,238 [salt.state       ][INFO    ][24590] Running state [virt.set_autostart] at time 09:54:17.237738
2017-09-18 09:54:17,238 [salt.state       ][INFO    ][24590] Executing state module.run for virt.set_autostart
2017-09-18 09:54:17,243 [salt.loaded.int.module.cmdmod][INFO    ][24590] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-18 09:54:17,276 [salt.state       ][INFO    ][24590] unless execution succeeded
2017-09-18 09:54:17,285 [salt.state       ][INFO    ][24590] Completed state [virt.set_autostart] at time 09:54:17.284730 duration_in_ms=46.992
2017-09-18 09:54:17,289 [salt.minion      ][INFO    ][24590] Returning information for job: 20170918095412184083
2017-09-18 09:55:35,024 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170918095535013177
2017-09-18 09:55:35,047 [salt.minion      ][INFO    ][24696] Starting a new job with PID 24696
2017-09-18 09:55:38,666 [salt.state       ][INFO    ][24696] Loading fresh modules for state activity
2017-09-18 09:55:38,840 [salt.state       ][ERROR   ][24696] No contents found in top file
2017-09-18 09:55:38,842 [salt.utils.extmods][INFO    ][24696] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-18 09:55:38,848 [salt.utils.extmods][INFO    ][24696] Syncing beacons for environment 'base'
2017-09-18 09:55:38,848 [salt.utils.extmods][INFO    ][24696] Loading cache from salt://_beacons, for base)
2017-09-18 09:55:38,848 [salt.fileclient  ][INFO    ][24696] Caching directory '_beacons/' for environment 'base'
2017-09-18 09:55:38,938 [salt.utils.extmods][INFO    ][24696] Syncing modules for environment 'base'
2017-09-18 09:55:38,938 [salt.utils.extmods][INFO    ][24696] Loading cache from salt://_modules, for base)
2017-09-18 09:55:38,938 [salt.fileclient  ][INFO    ][24696] Caching directory '_modules/' for environment 'base'
2017-09-18 09:55:38,989 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-18 09:55:38,999 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-18 09:55:39,012 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-18 09:55:39,021 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-18 09:55:39,031 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-18 09:55:39,041 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-18 09:55:39,808 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-18 09:55:39,823 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-18 09:55:39,842 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-18 09:55:39,865 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-18 09:55:39,880 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-18 09:55:39,897 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-18 09:55:39,910 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-18 09:55:40,022 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-18 09:55:40,061 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-18 09:55:40,180 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-18 09:55:40,196 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-18 09:55:40,214 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-18 09:55:40,225 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-18 09:55:40,293 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-18 09:55:40,397 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-18 09:55:40,471 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-18 09:55:40,511 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-18 09:55:40,535 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-18 09:55:40,547 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-18 09:55:40,566 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-18 09:55:40,622 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-18 09:55:40,650 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-18 09:55:40,670 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-18 09:55:40,692 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-18 09:55:40,737 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-18 09:55:40,827 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-18 09:55:40,832 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-18 09:55:40,832 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-18 09:55:40,833 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-18 09:55:40,833 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-18 09:55:40,834 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-18 09:55:40,834 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-18 09:55:40,834 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-18 09:55:40,835 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-18 09:55:40,835 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-18 09:55:40,836 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-18 09:55:40,836 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-18 09:55:40,836 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-18 09:55:40,837 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-18 09:55:40,837 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-18 09:55:40,837 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-18 09:55:40,838 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-18 09:55:40,838 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-18 09:55:40,839 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-18 09:55:40,839 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-18 09:55:40,839 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-18 09:55:40,840 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-18 09:55:40,840 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-18 09:55:40,841 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-18 09:55:40,841 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-18 09:55:40,842 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-18 09:55:40,842 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-18 09:55:40,842 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-18 09:55:40,843 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-18 09:55:40,843 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-18 09:55:40,843 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-18 09:55:40,844 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-18 09:55:40,844 [salt.utils.extmods][INFO    ][24696] 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-18 09:55:40,844 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-18 09:55:40,845 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-18 09:55:40,851 [salt.utils.extmods][INFO    ][24696] Syncing states for environment 'base'
2017-09-18 09:55:40,851 [salt.utils.extmods][INFO    ][24696] Loading cache from salt://_states, for base)
2017-09-18 09:55:40,851 [salt.fileclient  ][INFO    ][24696] Caching directory '_states/' for environment 'base'
2017-09-18 09:55:40,961 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-18 09:55:40,973 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-18 09:55:40,992 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-18 09:55:41,049 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-18 09:55:41,078 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-18 09:55:41,103 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-18 09:55:41,144 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-18 09:55:41,157 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-18 09:55:41,178 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-18 09:55:41,201 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-18 09:55:41,246 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-18 09:55:41,273 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-18 09:55:41,298 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-18 09:55:41,323 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-18 09:55:41,351 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-18 09:55:41,368 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-18 09:55:41,382 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-18 09:55:41,638 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-18 09:55:41,660 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-18 09:55:41,674 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-18 09:55:41,736 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-18 09:55:41,746 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-18 09:55:41,794 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-18 09:55:41,816 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-18 09:55:41,960 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-18 09:55:41,973 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-18 09:55:41,986 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-18 09:55:42,008 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-18 09:55:42,059 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-18 09:55:42,066 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-18 09:55:42,067 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-18 09:55:42,067 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-18 09:55:42,068 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-18 09:55:42,069 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-18 09:55:42,069 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-18 09:55:42,070 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-18 09:55:42,070 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-18 09:55:42,071 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-18 09:55:42,071 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-18 09:55:42,072 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-18 09:55:42,072 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-18 09:55:42,073 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-18 09:55:42,073 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-18 09:55:42,074 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-18 09:55:42,075 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-18 09:55:42,075 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-18 09:55:42,076 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-18 09:55:42,076 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-18 09:55:42,077 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-18 09:55:42,077 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-18 09:55:42,078 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-18 09:55:42,078 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-18 09:55:42,078 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-18 09:55:42,079 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-18 09:55:42,080 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-18 09:55:42,080 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-18 09:55:42,081 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-18 09:55:42,081 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-18 09:55:42,082 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-18 09:55:42,086 [salt.utils.extmods][INFO    ][24696] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-18 09:55:42,091 [salt.utils.extmods][INFO    ][24696] Syncing sdb for environment 'base'
2017-09-18 09:55:42,091 [salt.utils.extmods][INFO    ][24696] Loading cache from salt://_sdb, for base)
2017-09-18 09:55:42,091 [salt.fileclient  ][INFO    ][24696] Caching directory '_sdb/' for environment 'base'
2017-09-18 09:55:42,163 [salt.utils.extmods][INFO    ][24696] Syncing grains for environment 'base'
2017-09-18 09:55:42,163 [salt.utils.extmods][INFO    ][24696] Loading cache from salt://_grains, for base)
2017-09-18 09:55:42,163 [salt.fileclient  ][INFO    ][24696] Caching directory '_grains/' for environment 'base'
2017-09-18 09:55:42,239 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-18 09:55:42,252 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-18 09:55:42,307 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-18 09:55:42,326 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-18 09:55:42,336 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-18 09:55:42,351 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-18 09:55:42,364 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-18 09:55:42,376 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-18 09:55:42,625 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-18 09:55:42,641 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-18 09:55:42,653 [salt.fileclient  ][INFO    ][24696] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-18 09:55:42,660 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-18 09:55:42,660 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-18 09:55:42,660 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-18 09:55:42,661 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-18 09:55:42,661 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-18 09:55:42,662 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-18 09:55:42,662 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-18 09:55:42,662 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-18 09:55:42,663 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-18 09:55:42,663 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-18 09:55:42,664 [salt.utils.extmods][INFO    ][24696] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-18 09:55:42,666 [salt.utils.extmods][INFO    ][24696] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-18 09:55:42,672 [salt.utils.extmods][INFO    ][24696] Syncing renderers for environment 'base'
2017-09-18 09:55:42,672 [salt.utils.extmods][INFO    ][24696] Loading cache from salt://_renderers, for base)
2017-09-18 09:55:42,673 [salt.fileclient  ][INFO    ][24696] Caching directory '_renderers/' for environment 'base'
2017-09-18 09:55:43,538 [salt.utils.extmods][INFO    ][24696] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-18 09:55:43,544 [salt.utils.extmods][INFO    ][24696] Syncing returners for environment 'base'
2017-09-18 09:55:43,545 [salt.utils.extmods][INFO    ][24696] Loading cache from salt://_returners, for base)
2017-09-18 09:55:43,545 [salt.fileclient  ][INFO    ][24696] Caching directory '_returners/' for environment 'base'
2017-09-18 09:55:43,575 [salt.utils.extmods][INFO    ][24696] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-18 09:55:43,580 [salt.utils.extmods][INFO    ][24696] Syncing output for environment 'base'
2017-09-18 09:55:43,580 [salt.utils.extmods][INFO    ][24696] Loading cache from salt://_output, for base)
2017-09-18 09:55:43,581 [salt.fileclient  ][INFO    ][24696] Caching directory '_output/' for environment 'base'
2017-09-18 09:55:43,620 [salt.utils.extmods][INFO    ][24696] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-18 09:55:43,625 [salt.utils.extmods][INFO    ][24696] Syncing utils for environment 'base'
2017-09-18 09:55:43,626 [salt.utils.extmods][INFO    ][24696] Loading cache from salt://_utils, for base)
2017-09-18 09:55:43,626 [salt.fileclient  ][INFO    ][24696] Caching directory '_utils/' for environment 'base'
2017-09-18 09:55:43,661 [salt.utils.extmods][INFO    ][24696] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-18 09:55:43,665 [salt.utils.extmods][INFO    ][24696] Syncing log_handlers for environment 'base'
2017-09-18 09:55:43,666 [salt.utils.extmods][INFO    ][24696] Loading cache from salt://_log_handlers, for base)
2017-09-18 09:55:43,666 [salt.fileclient  ][INFO    ][24696] Caching directory '_log_handlers/' for environment 'base'
2017-09-18 09:55:43,704 [salt.utils.extmods][INFO    ][24696] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-18 09:55:43,709 [salt.utils.extmods][INFO    ][24696] Syncing proxy for environment 'base'
2017-09-18 09:55:43,710 [salt.utils.extmods][INFO    ][24696] Loading cache from salt://_proxy, for base)
2017-09-18 09:55:43,710 [salt.fileclient  ][INFO    ][24696] Caching directory '_proxy/' for environment 'base'
2017-09-18 09:55:43,743 [salt.utils.extmods][INFO    ][24696] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-18 09:55:43,748 [salt.utils.extmods][INFO    ][24696] Syncing engines for environment 'base'
2017-09-18 09:55:43,749 [salt.utils.extmods][INFO    ][24696] Loading cache from salt://_engines, for base)
2017-09-18 09:55:43,749 [salt.fileclient  ][INFO    ][24696] Caching directory '_engines/' for environment 'base'
2017-09-18 09:55:43,789 [salt.minion      ][INFO    ][24696] Returning information for job: 20170918095535013177
2017-09-18 10:07:45,983 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command test.ping with jid 20170918100745976786
2017-09-18 10:07:46,010 [salt.minion      ][INFO    ][25005] Starting a new job with PID 25005
2017-09-18 10:07:46,069 [salt.minion      ][INFO    ][25005] Returning information for job: 20170918100745976786
2017-09-18 10:09:47,099 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command state.sls with jid 20170918100947091191
2017-09-18 10:09:47,123 [salt.minion      ][INFO    ][25041] Starting a new job with PID 25041
2017-09-18 10:09:48,547 [salt.state       ][INFO    ][25041] Loading fresh modules for state activity
2017-09-18 10:09:48,665 [salt.fileclient  ][INFO    ][25041] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-18 10:09:48,692 [salt.fileclient  ][INFO    ][25041] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-18 10:09:48,732 [salt.fileclient  ][INFO    ][25041] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-18 10:09:49,211 [salt.state       ][INFO    ][25041] Running state [lsof] at time 10:09:49.210872
2017-09-18 10:09:49,211 [salt.state       ][INFO    ][25041] Executing state pkg.installed for lsof
2017-09-18 10:09:49,212 [salt.loaded.int.module.cmdmod][INFO    ][25041] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 10:09:49,658 [salt.state       ][INFO    ][25041] Package lsof is already installed
2017-09-18 10:09:49,658 [salt.state       ][INFO    ][25041] Completed state [lsof] at time 10:09:49.658065 duration_in_ms=447.193
2017-09-18 10:09:49,658 [salt.state       ][INFO    ][25041] Running state [keepalived] at time 10:09:49.658445
2017-09-18 10:09:49,659 [salt.state       ][INFO    ][25041] Executing state pkg.installed for keepalived
2017-09-18 10:09:49,682 [salt.loaded.int.module.cmdmod][INFO    ][25041] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-18 10:09:52,050 [salt.loaded.int.module.cmdmod][INFO    ][25041] 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-18 10:09:57,138 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command saltutil.find_job with jid 20170918100957129727
2017-09-18 10:09:57,159 [salt.minion      ][INFO    ][26322] Starting a new job with PID 26322
2017-09-18 10:09:57,178 [salt.minion      ][INFO    ][26322] Returning information for job: 20170918100957129727
2017-09-18 10:10:01,406 [salt.loaded.int.module.cmdmod][INFO    ][25041] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 10:10:01,462 [salt.state       ][INFO    ][25041] 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-18 10:10:01,494 [salt.state       ][INFO    ][25041] Loading fresh modules for state activity
2017-09-18 10:10:01,524 [salt.state       ][INFO    ][25041] Completed state [keepalived] at time 10:10:01.523764 duration_in_ms=11865.318
2017-09-18 10:10:01,528 [salt.state       ][INFO    ][25041] Running state [/etc/keepalived/keepalived.conf] at time 10:10:01.527876
2017-09-18 10:10:01,528 [salt.state       ][INFO    ][25041] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-18 10:10:01,561 [salt.fileclient  ][INFO    ][25041] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-18 10:10:01,602 [salt.fileclient  ][INFO    ][25041] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-18 10:10:01,611 [salt.state       ][INFO    ][25041] File changed:
New file
2017-09-18 10:10:01,611 [salt.state       ][INFO    ][25041] Completed state [/etc/keepalived/keepalived.conf] at time 10:10:01.611009 duration_in_ms=83.132
2017-09-18 10:10:01,693 [salt.state       ][INFO    ][25041] Running state [keepalived] at time 10:10:01.692464
2017-09-18 10:10:01,693 [salt.state       ][INFO    ][25041] Executing state service.running for keepalived
2017-09-18 10:10:01,697 [salt.loaded.int.module.cmdmod][INFO    ][25041] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-18 10:10:01,713 [salt.loaded.int.module.cmdmod][INFO    ][25041] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-18 10:10:01,728 [salt.loaded.int.module.cmdmod][INFO    ][25041] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-18 10:10:01,743 [salt.loaded.int.module.cmdmod][INFO    ][25041] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-18 10:10:01,760 [salt.loaded.int.module.cmdmod][INFO    ][25041] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-18 10:10:01,837 [salt.loaded.int.module.cmdmod][INFO    ][25041] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-18 10:10:01,853 [salt.loaded.int.module.cmdmod][INFO    ][25041] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-18 10:10:01,870 [salt.loaded.int.module.cmdmod][INFO    ][25041] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-18 10:10:01,883 [salt.state       ][INFO    ][25041] {'keepalived': True}
2017-09-18 10:10:01,883 [salt.state       ][INFO    ][25041] Completed state [keepalived] at time 10:10:01.882892 duration_in_ms=190.424
2017-09-18 10:10:01,885 [salt.minion      ][INFO    ][25041] Returning information for job: 20170918100947091191
2017-09-18 10:11:58,813 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command pillar.get with jid 20170918101158802874
2017-09-18 10:11:58,839 [salt.minion      ][INFO    ][26675] Starting a new job with PID 26675
2017-09-18 10:11:58,846 [salt.minion      ][INFO    ][26675] Returning information for job: 20170918101158802874
2017-09-18 10:18:07,083 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command state.sls with jid 20170918101807075443
2017-09-18 10:18:07,105 [salt.minion      ][INFO    ][26802] Starting a new job with PID 26802
2017-09-18 10:18:08,835 [salt.state       ][INFO    ][26802] Loading fresh modules for state activity
2017-09-18 10:18:08,874 [salt.fileclient  ][INFO    ][26802] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-18 10:18:08,904 [salt.fileclient  ][INFO    ][26802] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-18 10:18:09,251 [salt.state       ][INFO    ][26802] Running state [attr] at time 10:18:09.251453
2017-09-18 10:18:09,252 [salt.state       ][INFO    ][26802] Executing state pkg.installed for attr
2017-09-18 10:18:09,252 [salt.loaded.int.module.cmdmod][INFO    ][26802] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 10:18:09,734 [salt.loaded.int.module.cmdmod][INFO    ][26802] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-18 10:18:12,023 [salt.loaded.int.module.cmdmod][INFO    ][26802] 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-18 10:18:15,157 [salt.loaded.int.module.cmdmod][INFO    ][26802] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 10:18:15,209 [salt.state       ][INFO    ][26802] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-18 10:18:15,232 [salt.state       ][INFO    ][26802] Loading fresh modules for state activity
2017-09-18 10:18:15,268 [salt.state       ][INFO    ][26802] Completed state [attr] at time 10:18:15.268104 duration_in_ms=6016.65
2017-09-18 10:18:15,280 [salt.state       ][INFO    ][26802] Running state [glusterfs-server] at time 10:18:15.280286
2017-09-18 10:18:15,281 [salt.state       ][INFO    ][26802] Executing state pkg.installed for glusterfs-server
2017-09-18 10:18:15,615 [salt.loaded.int.module.cmdmod][INFO    ][26802] 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-18 10:18:17,171 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command saltutil.find_job with jid 20170918101817162341
2017-09-18 10:18:17,191 [salt.minion      ][INFO    ][27802] Starting a new job with PID 27802
2017-09-18 10:18:17,211 [salt.minion      ][INFO    ][27802] Returning information for job: 20170918101817162341
2017-09-18 10:18:27,385 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command saltutil.find_job with jid 20170918101827374913
2017-09-18 10:18:27,407 [salt.minion      ][INFO    ][30505] Starting a new job with PID 30505
2017-09-18 10:18:27,432 [salt.minion      ][INFO    ][30505] Returning information for job: 20170918101827374913
2017-09-18 10:18:37,552 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command saltutil.find_job with jid 20170918101837543752
2017-09-18 10:18:37,556 [salt.loaded.int.module.cmdmod][INFO    ][26802] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 10:18:37,570 [salt.minion      ][INFO    ][31107] Starting a new job with PID 31107
2017-09-18 10:18:37,587 [salt.minion      ][INFO    ][31107] Returning information for job: 20170918101837543752
2017-09-18 10:18:37,605 [salt.state       ][INFO    ][26802] 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-18 10:18:37,619 [salt.state       ][INFO    ][26802] Loading fresh modules for state activity
2017-09-18 10:18:37,640 [salt.state       ][INFO    ][26802] Completed state [glusterfs-server] at time 10:18:37.639597 duration_in_ms=22359.311
2017-09-18 10:18:37,647 [salt.state       ][INFO    ][26802] Running state [bc] at time 10:18:37.647015
2017-09-18 10:18:37,647 [salt.state       ][INFO    ][26802] Executing state pkg.installed for bc
2017-09-18 10:18:37,919 [salt.loaded.int.module.cmdmod][INFO    ][26802] 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-18 10:18:41,144 [salt.loaded.int.module.cmdmod][INFO    ][26802] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 10:18:41,198 [salt.state       ][INFO    ][26802] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-18 10:18:41,212 [salt.state       ][INFO    ][26802] Loading fresh modules for state activity
2017-09-18 10:18:41,236 [salt.state       ][INFO    ][26802] Completed state [bc] at time 10:18:41.235605 duration_in_ms=3588.589
2017-09-18 10:18:41,333 [salt.state       ][INFO    ][26802] Running state [glusterfs-server] at time 10:18:41.333345
2017-09-18 10:18:41,334 [salt.state       ][INFO    ][26802] Executing state service.running for glusterfs-server
2017-09-18 10:18:41,336 [salt.loaded.int.module.cmdmod][INFO    ][26802] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-18 10:18:41,352 [salt.loaded.int.module.cmdmod][INFO    ][26802] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-18 10:18:41,367 [salt.loaded.int.module.cmdmod][INFO    ][26802] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-18 10:18:41,385 [salt.state       ][INFO    ][26802] The service glusterfs-server is already running
2017-09-18 10:18:41,385 [salt.state       ][INFO    ][26802] Completed state [glusterfs-server] at time 10:18:41.385157 duration_in_ms=51.82
2017-09-18 10:18:41,388 [salt.state       ][INFO    ][26802] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:18:41.388085
2017-09-18 10:18:41,389 [salt.state       ][INFO    ][26802] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-18 10:18:41,402 [salt.state       ][INFO    ][26802] File changed:
New file
2017-09-18 10:18:41,402 [salt.state       ][INFO    ][26802] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:18:41.401975 duration_in_ms=13.891
2017-09-18 10:18:41,402 [salt.state       ][INFO    ][26802] Running state [/srv/glusterfs/glance] at time 10:18:41.402293
2017-09-18 10:18:41,403 [salt.state       ][INFO    ][26802] Executing state file.directory for /srv/glusterfs/glance
2017-09-18 10:18:41,404 [salt.state       ][INFO    ][26802] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-18 10:18:41,404 [salt.state       ][INFO    ][26802] Completed state [/srv/glusterfs/glance] at time 10:18:41.404003 duration_in_ms=1.711
2017-09-18 10:18:41,404 [salt.state       ][INFO    ][26802] Running state [/srv/glusterfs/keystone-keys] at time 10:18:41.404311
2017-09-18 10:18:41,405 [salt.state       ][INFO    ][26802] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-18 10:18:41,405 [salt.state       ][INFO    ][26802] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-18 10:18:41,406 [salt.state       ][INFO    ][26802] Completed state [/srv/glusterfs/keystone-keys] at time 10:18:41.405656 duration_in_ms=1.345
2017-09-18 10:18:41,406 [salt.state       ][INFO    ][26802] Running state [/srv/glusterfs/nova_instances] at time 10:18:41.405964
2017-09-18 10:18:41,406 [salt.state       ][INFO    ][26802] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-18 10:18:41,407 [salt.state       ][INFO    ][26802] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-18 10:18:41,407 [salt.state       ][INFO    ][26802] Completed state [/srv/glusterfs/nova_instances] at time 10:18:41.407289 duration_in_ms=1.324
2017-09-18 10:18:41,408 [salt.state       ][INFO    ][26802] Running state [/srv/glusterfs/keystone-credential-keys] at time 10:18:41.407596
2017-09-18 10:18:41,408 [salt.state       ][INFO    ][26802] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-18 10:18:41,409 [salt.state       ][INFO    ][26802] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-18 10:18:41,409 [salt.state       ][INFO    ][26802] Completed state [/srv/glusterfs/keystone-credential-keys] at time 10:18:41.408933 duration_in_ms=1.337
2017-09-18 10:18:41,410 [salt.minion      ][INFO    ][26802] Returning information for job: 20170918101807075443
2017-09-18 10:18:42,577 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command test.ping with jid 20170918101842567830
2017-09-18 10:18:42,598 [salt.minion      ][INFO    ][31551] Starting a new job with PID 31551
2017-09-18 10:18:42,657 [salt.minion      ][INFO    ][31551] Returning information for job: 20170918101842567830
2017-09-18 10:19:23,011 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command state.sls with jid 20170918101923004076
2017-09-18 10:19:23,033 [salt.minion      ][INFO    ][31770] Starting a new job with PID 31770
2017-09-18 10:19:24,471 [salt.state       ][INFO    ][31770] Loading fresh modules for state activity
2017-09-18 10:19:24,512 [salt.fileclient  ][INFO    ][31770] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-18 10:19:24,569 [salt.fileclient  ][INFO    ][31770] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-18 10:19:24,662 [salt.fileclient  ][INFO    ][31770] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-18 10:19:24,684 [salt.fileclient  ][INFO    ][31770] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-18 10:19:25,072 [salt.state       ][INFO    ][31770] Running state [attr] at time 10:19:25.071819
2017-09-18 10:19:25,072 [salt.state       ][INFO    ][31770] Executing state pkg.installed for attr
2017-09-18 10:19:25,073 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 10:19:25,487 [salt.state       ][INFO    ][31770] Package attr is already installed
2017-09-18 10:19:25,487 [salt.state       ][INFO    ][31770] Completed state [attr] at time 10:19:25.487175 duration_in_ms=415.355
2017-09-18 10:19:25,487 [salt.state       ][INFO    ][31770] Running state [glusterfs-server] at time 10:19:25.487433
2017-09-18 10:19:25,488 [salt.state       ][INFO    ][31770] Executing state pkg.installed for glusterfs-server
2017-09-18 10:19:25,491 [salt.state       ][INFO    ][31770] Package glusterfs-server is already installed
2017-09-18 10:19:25,491 [salt.state       ][INFO    ][31770] Completed state [glusterfs-server] at time 10:19:25.491288 duration_in_ms=3.856
2017-09-18 10:19:25,492 [salt.state       ][INFO    ][31770] Running state [bc] at time 10:19:25.491489
2017-09-18 10:19:25,492 [salt.state       ][INFO    ][31770] Executing state pkg.installed for bc
2017-09-18 10:19:25,501 [salt.state       ][INFO    ][31770] Package bc is already installed
2017-09-18 10:19:25,502 [salt.state       ][INFO    ][31770] Completed state [bc] at time 10:19:25.501825 duration_in_ms=10.335
2017-09-18 10:19:25,504 [salt.state       ][INFO    ][31770] Running state [glusterfs-server] at time 10:19:25.504169
2017-09-18 10:19:25,505 [salt.state       ][INFO    ][31770] Executing state service.running for glusterfs-server
2017-09-18 10:19:25,506 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-18 10:19:25,523 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-18 10:19:25,610 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-18 10:19:25,636 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-18 10:19:25,649 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-18 10:19:25,665 [salt.state       ][INFO    ][31770] The service glusterfs-server is already running
2017-09-18 10:19:25,666 [salt.state       ][INFO    ][31770] Completed state [glusterfs-server] at time 10:19:25.665745 duration_in_ms=161.574
2017-09-18 10:19:25,672 [salt.state       ][INFO    ][31770] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:19:25.671618
2017-09-18 10:19:25,672 [salt.state       ][INFO    ][31770] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-18 10:19:25,687 [salt.state       ][INFO    ][31770] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-18 10:19:25,687 [salt.state       ][INFO    ][31770] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:19:25.686922 duration_in_ms=15.304
2017-09-18 10:19:25,687 [salt.state       ][INFO    ][31770] Running state [/srv/glusterfs/glance] at time 10:19:25.687322
2017-09-18 10:19:25,688 [salt.state       ][INFO    ][31770] Executing state file.directory for /srv/glusterfs/glance
2017-09-18 10:19:25,689 [salt.state       ][INFO    ][31770] Directory /srv/glusterfs/glance is in the correct state
2017-09-18 10:19:25,689 [salt.state       ][INFO    ][31770] Completed state [/srv/glusterfs/glance] at time 10:19:25.688816 duration_in_ms=1.493
2017-09-18 10:19:25,689 [salt.state       ][INFO    ][31770] Running state [/srv/glusterfs/keystone-keys] at time 10:19:25.689161
2017-09-18 10:19:25,690 [salt.state       ][INFO    ][31770] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-18 10:19:25,690 [salt.state       ][INFO    ][31770] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-18 10:19:25,691 [salt.state       ][INFO    ][31770] Completed state [/srv/glusterfs/keystone-keys] at time 10:19:25.690623 duration_in_ms=1.461
2017-09-18 10:19:25,691 [salt.state       ][INFO    ][31770] Running state [/srv/glusterfs/nova_instances] at time 10:19:25.690972
2017-09-18 10:19:25,691 [salt.state       ][INFO    ][31770] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-18 10:19:25,692 [salt.state       ][INFO    ][31770] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-18 10:19:25,692 [salt.state       ][INFO    ][31770] Completed state [/srv/glusterfs/nova_instances] at time 10:19:25.692380 duration_in_ms=1.408
2017-09-18 10:19:25,693 [salt.state       ][INFO    ][31770] Running state [/srv/glusterfs/keystone-credential-keys] at time 10:19:25.692733
2017-09-18 10:19:25,693 [salt.state       ][INFO    ][31770] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-18 10:19:25,694 [salt.state       ][INFO    ][31770] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-18 10:19:25,694 [salt.state       ][INFO    ][31770] Completed state [/srv/glusterfs/keystone-credential-keys] at time 10:19:25.694218 duration_in_ms=1.484
2017-09-18 10:19:25,800 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command ['git', '--version'] in directory '/root'
2017-09-18 10:19:25,870 [salt.state       ][INFO    ][31770] Running state [sleep 5] at time 10:19:25.869692
2017-09-18 10:19:25,870 [salt.state       ][INFO    ][31770] Executing state cmd.wait for sleep 5
2017-09-18 10:19:25,870 [salt.state       ][INFO    ][31770] No changes made for sleep 5
2017-09-18 10:19:25,870 [salt.state       ][INFO    ][31770] Completed state [sleep 5] at time 10:19:25.870431 duration_in_ms=0.742
2017-09-18 10:19:25,871 [salt.state       ][INFO    ][31770] Running state [10.167.4.141] at time 10:19:25.870923
2017-09-18 10:19:25,871 [salt.state       ][INFO    ][31770] Executing state glusterfs.peered for 10.167.4.141
2017-09-18 10:19:25,872 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:25,888 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:25,992 [salt.state       ][INFO    ][31770] Host 10.167.4.141 already peered
2017-09-18 10:19:25,992 [salt.state       ][INFO    ][31770] Completed state [10.167.4.141] at time 10:19:25.992382 duration_in_ms=121.458
2017-09-18 10:19:25,998 [salt.state       ][INFO    ][31770] Running state [10.167.4.142] at time 10:19:25.997949
2017-09-18 10:19:25,998 [salt.state       ][INFO    ][31770] Executing state glusterfs.peered for 10.167.4.142
2017-09-18 10:19:25,999 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:26,017 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:26,122 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:26,139 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:26,236 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:26,254 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:26,362 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:26,375 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:26,483 [salt.state       ][INFO    ][31770] Peering with localhost is not needed
2017-09-18 10:19:26,483 [salt.state       ][INFO    ][31770] Completed state [10.167.4.142] at time 10:19:26.483127 duration_in_ms=485.177
2017-09-18 10:19:26,489 [salt.state       ][INFO    ][31770] Running state [10.167.4.143] at time 10:19:26.489090
2017-09-18 10:19:26,490 [salt.state       ][INFO    ][31770] Executing state glusterfs.peered for 10.167.4.143
2017-09-18 10:19:26,491 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:26,507 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:26,613 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:26,630 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:26,744 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:26,758 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:26,870 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:26,884 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:26,993 [salt.state       ][INFO    ][31770] {'new': {'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': ['10.167.4.143'], '10.167.4.141': []}, 'old': {'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': [], '10.167.4.141': []}}
2017-09-18 10:19:26,993 [salt.state       ][INFO    ][31770] Completed state [10.167.4.143] at time 10:19:26.993056 duration_in_ms=503.966
2017-09-18 10:19:26,995 [salt.state       ][INFO    ][31770] Running state [glance] at time 10:19:26.994942
2017-09-18 10:19:26,995 [salt.state       ][INFO    ][31770] Executing state glusterfs.created for glance
2017-09-18 10:19:26,996 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:27,014 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:27,115 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:27,133 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:27,246 [salt.state       ][INFO    ][31770] Volume glance already exists and is started.
2017-09-18 10:19:27,246 [salt.state       ][INFO    ][31770] Completed state [glance] at time 10:19:27.246360 duration_in_ms=251.417
2017-09-18 10:19:27,253 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 10:19:27.253385
2017-09-18 10:19:27,254 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-18 10:19:27,255 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-18 10:19:27,359 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:27,360 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 10:19:27.359442 duration_in_ms=106.057
2017-09-18 10:19:27,361 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 10:19:27.360538
2017-09-18 10:19:27,361 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-18 10:19:27,362 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-18 10:19:27,457 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:27,458 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 10:19:27.457542 duration_in_ms=97.002
2017-09-18 10:19:27,459 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 10:19:27.458574
2017-09-18 10:19:27,459 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-18 10:19:27,460 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-18 10:19:27,564 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:27,564 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 10:19:27.564195 duration_in_ms=105.619
2017-09-18 10:19:27,566 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 10:19:27.565511
2017-09-18 10:19:27,566 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-18 10:19:27,567 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-18 10:19:27,664 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:27,664 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 10:19:27.664227 duration_in_ms=98.716
2017-09-18 10:19:27,665 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 10:19:27.665284
2017-09-18 10:19:27,666 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-18 10:19:27,667 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-18 10:19:27,770 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:27,771 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 10:19:27.770584 duration_in_ms=105.3
2017-09-18 10:19:27,773 [salt.state       ][INFO    ][31770] Running state [glance] at time 10:19:27.772734
2017-09-18 10:19:27,773 [salt.state       ][INFO    ][31770] Executing state glusterfs.started for glance
2017-09-18 10:19:27,774 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:27,791 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:27,900 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:27,916 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:28,030 [salt.state       ][INFO    ][31770] Volume glance is already started
2017-09-18 10:19:28,031 [salt.state       ][INFO    ][31770] Completed state [glance] at time 10:19:28.030514 duration_in_ms=257.778
2017-09-18 10:19:28,032 [salt.state       ][INFO    ][31770] Running state [keystone-keys] at time 10:19:28.032365
2017-09-18 10:19:28,033 [salt.state       ][INFO    ][31770] Executing state glusterfs.created for keystone-keys
2017-09-18 10:19:28,034 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:28,051 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:28,157 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:28,176 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:28,290 [salt.state       ][INFO    ][31770] Volume keystone-keys already exists and is started.
2017-09-18 10:19:28,291 [salt.state       ][INFO    ][31770] Completed state [keystone-keys] at time 10:19:28.290745 duration_in_ms=258.378
2017-09-18 10:19:28,298 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 10:19:28.298405
2017-09-18 10:19:28,299 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-18 10:19:28,300 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-18 10:19:28,406 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:28,407 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 10:19:28.406845 duration_in_ms=108.44
2017-09-18 10:19:28,408 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:19:28.407828
2017-09-18 10:19:28,408 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-18 10:19:28,409 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-18 10:19:28,516 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:28,516 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:19:28.516284 duration_in_ms=108.455
2017-09-18 10:19:28,518 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:19:28.517449
2017-09-18 10:19:28,518 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-18 10:19:28,519 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-18 10:19:28,623 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:28,624 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:19:28.623442 duration_in_ms=105.993
2017-09-18 10:19:28,625 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 10:19:28.624555
2017-09-18 10:19:28,625 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-18 10:19:28,626 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-18 10:19:28,735 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:28,735 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 10:19:28.735043 duration_in_ms=110.487
2017-09-18 10:19:28,736 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 10:19:28.736090
2017-09-18 10:19:28,737 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-18 10:19:28,738 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-18 10:19:28,847 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:28,848 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 10:19:28.847874 duration_in_ms=111.783
2017-09-18 10:19:28,850 [salt.state       ][INFO    ][31770] Running state [keystone-keys] at time 10:19:28.850402
2017-09-18 10:19:28,851 [salt.state       ][INFO    ][31770] Executing state glusterfs.started for keystone-keys
2017-09-18 10:19:28,852 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:28,869 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:28,974 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:28,991 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:29,100 [salt.state       ][INFO    ][31770] Volume keystone-keys is already started
2017-09-18 10:19:29,100 [salt.state       ][INFO    ][31770] Completed state [keystone-keys] at time 10:19:29.100166 duration_in_ms=249.763
2017-09-18 10:19:29,102 [salt.state       ][INFO    ][31770] Running state [nova_instances] at time 10:19:29.102203
2017-09-18 10:19:29,103 [salt.state       ][INFO    ][31770] Executing state glusterfs.created for nova_instances
2017-09-18 10:19:29,104 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:29,122 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:29,229 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:29,244 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:29,356 [salt.state       ][INFO    ][31770] Volume nova_instances already exists and is started.
2017-09-18 10:19:29,356 [salt.state       ][INFO    ][31770] Completed state [nova_instances] at time 10:19:29.356316 duration_in_ms=254.113
2017-09-18 10:19:29,364 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 10:19:29.364044
2017-09-18 10:19:29,365 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-18 10:19:29,366 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-18 10:19:29,471 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:29,472 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 10:19:29.471643 duration_in_ms=107.598
2017-09-18 10:19:29,473 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 10:19:29.472760
2017-09-18 10:19:29,473 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-09-18 10:19:29,474 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-18 10:19:29,584 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:29,584 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 10:19:29.584212 duration_in_ms=111.451
2017-09-18 10:19:29,585 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 10:19:29.585299
2017-09-18 10:19:29,586 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-09-18 10:19:29,587 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-18 10:19:29,699 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:29,699 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 10:19:29.699384 duration_in_ms=114.084
2017-09-18 10:19:29,701 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 10:19:29.700436
2017-09-18 10:19:29,701 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-09-18 10:19:29,702 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-09-18 10:19:29,803 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:29,803 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 10:19:29.803180 duration_in_ms=102.742
2017-09-18 10:19:29,804 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 10:19:29.804254
2017-09-18 10:19:29,805 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-18 10:19:29,806 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-18 10:19:29,919 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:29,919 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 10:19:29.919210 duration_in_ms=114.955
2017-09-18 10:19:29,922 [salt.state       ][INFO    ][31770] Running state [nova_instances] at time 10:19:29.921795
2017-09-18 10:19:29,922 [salt.state       ][INFO    ][31770] Executing state glusterfs.started for nova_instances
2017-09-18 10:19:29,923 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:29,940 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:30,048 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:30,062 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:30,166 [salt.state       ][INFO    ][31770] Volume nova_instances is already started
2017-09-18 10:19:30,166 [salt.state       ][INFO    ][31770] Completed state [nova_instances] at time 10:19:30.166097 duration_in_ms=244.301
2017-09-18 10:19:30,168 [salt.state       ][INFO    ][31770] Running state [keystone-credential-keys] at time 10:19:30.168057
2017-09-18 10:19:30,169 [salt.state       ][INFO    ][31770] Executing state glusterfs.created for keystone-credential-keys
2017-09-18 10:19:30,169 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:30,187 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:30,292 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:30,308 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:30,423 [salt.state       ][INFO    ][31770] Volume keystone-credential-keys already exists and is started.
2017-09-18 10:19:30,424 [salt.state       ][INFO    ][31770] Completed state [keystone-credential-keys] at time 10:19:30.424001 duration_in_ms=255.942
2017-09-18 10:19:30,432 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 10:19:30.432385
2017-09-18 10:19:30,433 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-18 10:19:30,434 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-18 10:19:30,543 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:30,543 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 10:19:30.543380 duration_in_ms=110.994
2017-09-18 10:19:30,545 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:19:30.544444
2017-09-18 10:19:30,545 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-18 10:19:30,546 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-18 10:19:30,653 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:30,653 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:19:30.653176 duration_in_ms=108.731
2017-09-18 10:19:30,654 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 10:19:30.654364
2017-09-18 10:19:30,655 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-18 10:19:30,656 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-18 10:19:30,768 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:30,768 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 10:19:30.768258 duration_in_ms=113.893
2017-09-18 10:19:30,769 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:19:30.769310
2017-09-18 10:19:30,770 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-18 10:19:30,771 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-18 10:19:30,877 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:30,878 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:19:30.877898 duration_in_ms=108.588
2017-09-18 10:19:30,879 [salt.state       ][INFO    ][31770] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 10:19:30.878947
2017-09-18 10:19:30,879 [salt.state       ][INFO    ][31770] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-18 10:19:30,880 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-18 10:19:30,980 [salt.state       ][INFO    ][31770] unless execution succeeded
2017-09-18 10:19:30,981 [salt.state       ][INFO    ][31770] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 10:19:30.980842 duration_in_ms=101.893
2017-09-18 10:19:30,983 [salt.state       ][INFO    ][31770] Running state [keystone-credential-keys] at time 10:19:30.983322
2017-09-18 10:19:30,984 [salt.state       ][INFO    ][31770] Executing state glusterfs.started for keystone-credential-keys
2017-09-18 10:19:30,985 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:31,001 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:31,108 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --version' in directory '/root'
2017-09-18 10:19:31,127 [salt.loaded.int.module.cmdmod][INFO    ][31770] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 10:19:31,265 [salt.state       ][INFO    ][31770] Volume keystone-credential-keys is already started
2017-09-18 10:19:31,265 [salt.state       ][INFO    ][31770] Completed state [keystone-credential-keys] at time 10:19:31.265193 duration_in_ms=281.87
2017-09-18 10:19:31,339 [salt.minion      ][INFO    ][31770] Returning information for job: 20170918101923004076
2017-09-18 10:19:36,017 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command test.ping with jid 20170918101936007635
2017-09-18 10:19:36,042 [salt.minion      ][INFO    ][32196] Starting a new job with PID 32196
2017-09-18 10:19:36,098 [salt.minion      ][INFO    ][32196] Returning information for job: 20170918101936007635
2017-09-18 10:19:36,486 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command cmd.run with jid 20170918101936476675
2017-09-18 10:19:36,510 [salt.minion      ][INFO    ][32201] Starting a new job with PID 32201
2017-09-18 10:19:36,516 [salt.loaded.int.module.cmdmod][INFO    ][32201] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-18 10:19:36,734 [salt.minion      ][INFO    ][32201] Returning information for job: 20170918101936476675
2017-09-18 10:54:11,765 [salt.utils.schedule][INFO    ][24490] Running scheduled job: __mine_interval
2017-09-18 11:21:47,696 [salt.minion      ][INFO    ][24490] User sudo_ubuntu Executing command cp.push_dir with jid 20170918112147683399
2017-09-18 11:21:47,722 [salt.minion      ][INFO    ][673] Starting a new job with PID 673
