2017-12-10 09:37:57,183 [salt.cli.daemons ][WARNING ][2166] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-10 09:38:26,128 [salt.state       ][ERROR   ][3636] No contents found in top file
2017-12-10 09:40:10,867 [salt.utils.parsers][WARNING ][2166] Minion received a SIGTERM. Exiting.
2017-12-10 09:44:39,426 [salt.cli.daemons ][WARNING ][3292] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-10 09:44:52,441 [py.warnings      ][WARNING ][3706] /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-12-10 09:46:02,034 [salt.loaded.int.module.cmdmod][ERROR   ][3706] 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-12-10 09:46:40,082 [salt.loaded.int.module.cmdmod][INFO    ][16028] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-10 09:46:40,089 [salt.loaded.int.module.cmdmod][INFO    ][16028] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-10 09:46:40,099 [salt.loaded.int.module.cmdmod][INFO    ][16028] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-10 09:46:40,108 [salt.utils.parsers][WARNING ][3292] Minion received a SIGTERM. Exiting.
2017-12-10 09:46:40,410 [salt.cli.daemons ][INFO    ][16102] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-odl-ha.local"
2017-12-10 09:46:41,037 [salt.minion      ][INFO    ][16102] Creating minion process manager
2017-12-10 09:46:41,037 [salt.cli.daemons ][WARNING ][16102] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-10 09:46:41,037 [salt.cli.daemons ][INFO    ][16102] The Salt Minion is starting up
2017-12-10 09:46:41,037 [salt.minion      ][INFO    ][16102] Minion is starting as user 'root'
2017-12-10 09:46:41,038 [salt.utils.event ][INFO    ][16102] Starting pull socket on /var/run/salt/minion/minion_event_2d6d7b82d1_pull.ipc
2017-12-10 09:46:42,144 [salt.loaded.int.module.cmdmod][INFO    ][16102] Executing command ['date', '+%z'] in directory '/root'
2017-12-10 09:46:42,156 [salt.utils.schedule][INFO    ][16102] Updating job settings for scheduled job: __mine_interval
2017-12-10 09:46:42,159 [salt.minion      ][INFO    ][16102] Added mine.update to scheduler
2017-12-10 09:46:42,185 [salt.minion      ][INFO    ][16102] Minion is ready to receive requests!
2017-12-10 09:46:43,186 [salt.utils.schedule][INFO    ][16102] Running scheduled job: __mine_interval
2017-12-10 09:47:05,788 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command state.apply with jid 20171210094705774601
2017-12-10 09:47:05,799 [salt.minion      ][INFO    ][16199] Starting a new job with PID 16199
2017-12-10 09:47:08,234 [salt.state       ][INFO    ][16199] Loading fresh modules for state activity
2017-12-10 09:47:08,263 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/init.sls'
2017-12-10 09:47:08,290 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-10 09:47:08,304 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-10 09:47:08,332 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:47:08,396 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-10 09:47:08,415 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 09:47:08,469 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-10 09:47:08,492 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-10 09:47:08,504 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-10 09:47:08,520 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-10 09:47:08,529 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-10 09:47:08,540 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-10 09:47:08,560 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-10 09:47:08,578 [py.warnings      ][WARNING ][16199] /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-12-10 09:47:08,578 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'salt-minion --version' in directory '/root'
2017-12-10 09:47:08,823 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'salt-minion --version' in directory '/root'
2017-12-10 09:47:09,083 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-10 09:47:09,104 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-10 09:47:09,115 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-10 09:47:09,128 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-10 09:47:09,207 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-10 09:47:09,223 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-10 09:47:09,247 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-10 09:47:09,261 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-10 09:47:09,283 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-10 09:47:09,322 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-10 09:47:09,393 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-10 09:47:09,420 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:47:09,490 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-10 09:47:09,511 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 09:47:09,567 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-10 09:47:09,595 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-10 09:47:09,610 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-10 09:47:09,629 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-10 09:47:09,637 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-10 09:47:09,647 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-10 09:47:09,667 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-10 09:47:09,685 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'salt-minion --version' in directory '/root'
2017-12-10 09:47:09,924 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'salt-minion --version' in directory '/root'
2017-12-10 09:47:10,183 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-10 09:47:10,202 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-10 09:47:10,215 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-10 09:47:10,226 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-10 09:47:10,269 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-10 09:47:10,284 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-10 09:47:10,310 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-10 09:47:10,325 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-10 09:47:10,346 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-10 09:47:10,387 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-10 09:47:10,469 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-10 09:47:10,540 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:47:10,603 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-10 09:47:10,621 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-10 09:47:10,652 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:47:11,007 [salt.state       ][INFO    ][16199] Running state [salt-minion] at time 09:47:11.006951
2017-12-10 09:47:11,007 [salt.state       ][INFO    ][16199] Executing state pkg.installed for salt-minion
2017-12-10 09:47:11,008 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 09:47:11,272 [salt.state       ][INFO    ][16199] Package salt-minion is already installed
2017-12-10 09:47:11,273 [salt.state       ][INFO    ][16199] Completed state [salt-minion] at time 09:47:11.272443 duration_in_ms=265.482
2017-12-10 09:47:11,273 [salt.state       ][INFO    ][16199] Running state [salt_minion_dependency_packages] at time 09:47:11.272713
2017-12-10 09:47:11,273 [salt.state       ][INFO    ][16199] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-10 09:47:11,277 [salt.state       ][INFO    ][16199] All specified packages are already installed
2017-12-10 09:47:11,277 [salt.state       ][INFO    ][16199] Completed state [salt_minion_dependency_packages] at time 09:47:11.276729 duration_in_ms=4.015
2017-12-10 09:47:11,278 [salt.state       ][INFO    ][16199] Running state [/etc/salt/minion.d/minion.conf] at time 09:47:11.278362
2017-12-10 09:47:11,279 [salt.state       ][INFO    ][16199] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-10 09:47:11,305 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-10 09:47:11,366 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:47:11,419 [salt.fileclient  ][INFO    ][16199] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 09:47:11,466 [salt.state       ][INFO    ][16199] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-10 09:47:11,466 [salt.state       ][INFO    ][16199] Completed state [/etc/salt/minion.d/minion.conf] at time 09:47:11.465957 duration_in_ms=187.595
2017-12-10 09:47:11,466 [salt.state       ][INFO    ][16199] Running state [/etc/salt/minion.d/_virt.conf] at time 09:47:11.466346
2017-12-10 09:47:11,467 [salt.state       ][INFO    ][16199] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-10 09:47:11,467 [salt.state       ][INFO    ][16199] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-10 09:47:11,467 [salt.state       ][INFO    ][16199] Completed state [/etc/salt/minion.d/_virt.conf] at time 09:47:11.467372 duration_in_ms=1.025
2017-12-10 09:47:11,469 [salt.state       ][INFO    ][16199] Running state [salt-minion] at time 09:47:11.469072
2017-12-10 09:47:11,469 [salt.state       ][INFO    ][16199] Executing state service.running for salt-minion
2017-12-10 09:47:11,470 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-10 09:47:11,483 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-10 09:47:11,489 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-10 09:47:11,496 [salt.state       ][INFO    ][16199] The service salt-minion is already running
2017-12-10 09:47:11,496 [salt.state       ][INFO    ][16199] Completed state [salt-minion] at time 09:47:11.496026 duration_in_ms=26.954
2017-12-10 09:47:11,498 [salt.state       ][INFO    ][16199] Running state [/etc/salt/grains.d] at time 09:47:11.497645
2017-12-10 09:47:11,498 [salt.state       ][INFO    ][16199] Executing state file.directory for /etc/salt/grains.d
2017-12-10 09:47:11,499 [salt.state       ][INFO    ][16199] Directory /etc/salt/grains.d is in the correct state
2017-12-10 09:47:11,499 [salt.state       ][INFO    ][16199] Completed state [/etc/salt/grains.d] at time 09:47:11.498683 duration_in_ms=1.037
2017-12-10 09:47:11,499 [salt.state       ][INFO    ][16199] Running state [/etc/salt/grains] at time 09:47:11.499252
2017-12-10 09:47:11,499 [salt.state       ][INFO    ][16199] Executing state file.managed for /etc/salt/grains
2017-12-10 09:47:11,500 [salt.state       ][INFO    ][16199] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-10 09:47:11,500 [salt.state       ][INFO    ][16199] Completed state [/etc/salt/grains] at time 09:47:11.499990 duration_in_ms=0.739
2017-12-10 09:47:11,500 [salt.state       ][INFO    ][16199] Running state [/etc/salt/grains.d/placeholder] at time 09:47:11.500365
2017-12-10 09:47:11,501 [salt.state       ][INFO    ][16199] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-10 09:47:11,501 [salt.state       ][INFO    ][16199] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-10 09:47:11,501 [salt.state       ][INFO    ][16199] Completed state [/etc/salt/grains.d/placeholder] at time 09:47:11.501102 duration_in_ms=0.736
2017-12-10 09:47:11,502 [salt.state       ][INFO    ][16199] Running state [/etc/salt/grains.d/sphinx] at time 09:47:11.501475
2017-12-10 09:47:11,502 [salt.state       ][INFO    ][16199] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-10 09:47:11,502 [salt.state       ][INFO    ][16199] File /etc/salt/grains.d/sphinx is in the correct state
2017-12-10 09:47:11,503 [salt.state       ][INFO    ][16199] Completed state [/etc/salt/grains.d/sphinx] at time 09:47:11.502638 duration_in_ms=1.164
2017-12-10 09:47:11,503 [salt.state       ][INFO    ][16199] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:47:11.503397
2017-12-10 09:47:11,504 [salt.state       ][INFO    ][16199] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:47:11,504 [salt.state       ][INFO    ][16199] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:47:11,504 [salt.state       ][INFO    ][16199] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:47:11.503974 duration_in_ms=0.577
2017-12-10 09:47:11,504 [salt.state       ][INFO    ][16199] Running state [/etc/salt/grains.d/dns_records] at time 09:47:11.504343
2017-12-10 09:47:11,505 [salt.state       ][INFO    ][16199] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-10 09:47:11,505 [salt.state       ][INFO    ][16199] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-10 09:47:11,505 [salt.state       ][INFO    ][16199] Completed state [/etc/salt/grains.d/dns_records] at time 09:47:11.505322 duration_in_ms=0.979
2017-12-10 09:47:11,506 [salt.state       ][INFO    ][16199] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:47:11.506081
2017-12-10 09:47:11,506 [salt.state       ][INFO    ][16199] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:47:11,507 [salt.state       ][INFO    ][16199] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:47:11,507 [salt.state       ][INFO    ][16199] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:47:11.506637 duration_in_ms=0.556
2017-12-10 09:47:11,507 [salt.state       ][INFO    ][16199] Running state [/etc/salt/grains.d/salt] at time 09:47:11.507006
2017-12-10 09:47:11,507 [salt.state       ][INFO    ][16199] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-10 09:47:11,508 [salt.state       ][INFO    ][16199] File /etc/salt/grains.d/salt is in the correct state
2017-12-10 09:47:11,508 [salt.state       ][INFO    ][16199] Completed state [/etc/salt/grains.d/salt] at time 09:47:11.507979 duration_in_ms=0.973
2017-12-10 09:47:11,509 [salt.state       ][INFO    ][16199] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:47:11.508784
2017-12-10 09:47:11,509 [salt.state       ][INFO    ][16199] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:47:11,509 [salt.state       ][INFO    ][16199] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:47:11,509 [salt.state       ][INFO    ][16199] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:47:11.509361 duration_in_ms=0.577
2017-12-10 09:47:11,511 [salt.state       ][INFO    ][16199] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:47:11.510928
2017-12-10 09:47:11,511 [salt.state       ][INFO    ][16199] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-10 09:47:11,511 [salt.state       ][INFO    ][16199] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-10 09:47:11,512 [salt.state       ][INFO    ][16199] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:47:11.511519 duration_in_ms=0.59
2017-12-10 09:47:11,512 [salt.state       ][INFO    ][16199] Running state [mine.update] at time 09:47:11.512066
2017-12-10 09:47:11,512 [salt.state       ][INFO    ][16199] Executing state module.wait for mine.update
2017-12-10 09:47:11,513 [salt.state       ][INFO    ][16199] No changes made for mine.update
2017-12-10 09:47:11,513 [salt.state       ][INFO    ][16199] Completed state [mine.update] at time 09:47:11.512649 duration_in_ms=0.583
2017-12-10 09:47:11,513 [salt.state       ][INFO    ][16199] Running state [ca-certificates] at time 09:47:11.512851
2017-12-10 09:47:11,513 [salt.state       ][INFO    ][16199] Executing state pkg.installed for ca-certificates
2017-12-10 09:47:11,517 [salt.state       ][INFO    ][16199] Package ca-certificates is already installed
2017-12-10 09:47:11,517 [salt.state       ][INFO    ][16199] Completed state [ca-certificates] at time 09:47:11.517076 duration_in_ms=4.225
2017-12-10 09:47:11,518 [salt.state       ][INFO    ][16199] Running state [update-ca-certificates] at time 09:47:11.517632
2017-12-10 09:47:11,518 [salt.state       ][INFO    ][16199] Executing state cmd.wait for update-ca-certificates
2017-12-10 09:47:11,518 [salt.state       ][INFO    ][16199] No changes made for update-ca-certificates
2017-12-10 09:47:11,518 [salt.state       ][INFO    ][16199] Completed state [update-ca-certificates] at time 09:47:11.518180 duration_in_ms=0.548
2017-12-10 09:47:11,518 [salt.state       ][INFO    ][16199] Running state [libvirt-dev] at time 09:47:11.518351
2017-12-10 09:47:11,519 [salt.state       ][INFO    ][16199] Executing state pkg.installed for libvirt-dev
2017-12-10 09:47:11,529 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-10 09:47:12,834 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'libvirt-dev'] in directory '/root'
2017-12-10 09:47:15,896 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094715874533
2017-12-10 09:47:15,906 [salt.minion      ][INFO    ][16907] Starting a new job with PID 16907
2017-12-10 09:47:15,917 [salt.minion      ][INFO    ][16907] Returning information for job: 20171210094715874533
2017-12-10 09:47:20,653 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 09:47:20,681 [salt.state       ][INFO    ][16199] Made the following changes:
'build-essential' changed from 'absent' to '12.1ubuntu2'
'libgomp1' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'c++-compiler' changed from 'absent' to '1'
'cpp' changed from 'absent' to '4:5.3.1-1ubuntu1'
'libalgorithm-merge-perl' changed from 'absent' to '0.08-3'
'binutils-gold' changed from 'absent' to '1'
'libfakeroot' changed from 'absent' to '1.20.2-1ubuntu1'
'linux-libc-dev' changed from 'absent' to '4.4.0-103.126'
'gcc-5' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libubsan0' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libalgorithm-diff-xs-perl' changed from 'absent' to '0.04-4build1'
'gcc' changed from 'absent' to '4:5.3.1-1ubuntu1'
'make' changed from 'absent' to '4.1-6'
'libitm1' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'g++' changed from 'absent' to '4:5.3.1-1ubuntu1'
'libfile-fcntllock-perl' changed from 'absent' to '0.22-3'
'c-compiler' changed from 'absent' to '1'
'libquadmath0' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'cpp:any' changed from 'absent' to '1'
'libmpc3' changed from 'absent' to '1.0.3-1'
'dpkg-dev' changed from 'absent' to '1.18.4ubuntu1.3'
'libmpx0' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libstdc++-5-dev' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'g++-5' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libc-dev' changed from 'absent' to '1'
'make:any' changed from 'absent' to '1'
'libatomic1' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libtsan0' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libasan2' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libvirt-dev' changed from 'absent' to '1.3.1-1ubuntu10.1~xenial1+contrail1'
'libstdc++-dev' changed from 'absent' to '1'
'libc6-dev' changed from 'absent' to '2.23-0ubuntu9'
'libdpkg-perl' changed from 'absent' to '1.18.4ubuntu1.3'
'libcilkrts5' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'elf-binutils' changed from 'absent' to '1'
'libxen-dev' changed from 'absent' to '4.6.5-0ubuntu1.4'
'manpages-dev' changed from 'absent' to '4.04-2'
'cpp-5' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'c++abi2-dev' changed from 'absent' to '1'
'libisl15' changed from 'absent' to '0.16.1-1'
'linux-kernel-headers' changed from 'absent' to '1'
'liblsan0' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'fakeroot' changed from 'absent' to '1.20.2-1ubuntu1'
'libc-dev-bin' changed from 'absent' to '2.23-0ubuntu9'
'libgcc-5-dev' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libcc1-0' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libalgorithm-diff-perl' changed from 'absent' to '1.19.03-1'
'binutils' changed from 'absent' to '2.26.1-1ubuntu1~16.04.5'
'pkg-config' changed from 'absent' to '0.29.1-0ubuntu1'

2017-12-10 09:47:20,693 [salt.state       ][INFO    ][16199] Loading fresh modules for state activity
2017-12-10 09:47:20,710 [salt.state       ][INFO    ][16199] Completed state [libvirt-dev] at time 09:47:20.709451 duration_in_ms=9191.099
2017-12-10 09:47:20,716 [salt.state       ][INFO    ][16199] Running state [pkg-config] at time 09:47:20.716350
2017-12-10 09:47:20,717 [salt.state       ][INFO    ][16199] Executing state pkg.installed for pkg-config
2017-12-10 09:47:20,961 [salt.state       ][INFO    ][16199] Package pkg-config is already installed
2017-12-10 09:47:20,961 [salt.state       ][INFO    ][16199] Completed state [pkg-config] at time 09:47:20.961130 duration_in_ms=244.78
2017-12-10 09:47:20,962 [salt.state       ][INFO    ][16199] Running state [virtng.init] at time 09:47:20.961554
2017-12-10 09:47:20,962 [salt.state       ][INFO    ][16199] Executing state module.run for virtng.init
2017-12-10 09:47:21,009 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command ['git', '--version'] in directory '/root'
2017-12-10 09:47:21,051 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:47:25,997 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094725978207
2017-12-10 09:47:26,008 [salt.minion      ][INFO    ][21906] Starting a new job with PID 21906
2017-12-10 09:47:26,019 [salt.minion      ][INFO    ][21906] Returning information for job: 20171210094725978207
2017-12-10 09:47:36,031 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094736014015
2017-12-10 09:47:36,041 [salt.minion      ][INFO    ][21911] Starting a new job with PID 21911
2017-12-10 09:47:36,051 [salt.minion      ][INFO    ][21911] Returning information for job: 20171210094736014015
2017-12-10 09:47:46,257 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094746240707
2017-12-10 09:47:46,268 [salt.minion      ][INFO    ][21916] Starting a new job with PID 21916
2017-12-10 09:47:46,279 [salt.minion      ][INFO    ][21916] Returning information for job: 20171210094746240707
2017-12-10 09:47:56,483 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094756468842
2017-12-10 09:47:56,493 [salt.minion      ][INFO    ][21921] Starting a new job with PID 21921
2017-12-10 09:47:56,504 [salt.minion      ][INFO    ][21921] Returning information for job: 20171210094756468842
2017-12-10 09:48:06,503 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094806489452
2017-12-10 09:48:06,513 [salt.minion      ][INFO    ][21926] Starting a new job with PID 21926
2017-12-10 09:48:06,524 [salt.minion      ][INFO    ][21926] Returning information for job: 20171210094806489452
2017-12-10 09:48:16,737 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094816717522
2017-12-10 09:48:16,747 [salt.minion      ][INFO    ][21931] Starting a new job with PID 21931
2017-12-10 09:48:16,758 [salt.minion      ][INFO    ][21931] Returning information for job: 20171210094816717522
2017-12-10 09:48:26,804 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094826785074
2017-12-10 09:48:26,815 [salt.minion      ][INFO    ][21936] Starting a new job with PID 21936
2017-12-10 09:48:26,825 [salt.minion      ][INFO    ][21936] Returning information for job: 20171210094826785074
2017-12-10 09:48:36,821 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094836807078
2017-12-10 09:48:36,831 [salt.minion      ][INFO    ][21951] Starting a new job with PID 21951
2017-12-10 09:48:36,841 [salt.minion      ][INFO    ][21951] Returning information for job: 20171210094836807078
2017-12-10 09:48:46,841 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094846825836
2017-12-10 09:48:46,851 [salt.minion      ][INFO    ][21956] Starting a new job with PID 21956
2017-12-10 09:48:46,861 [salt.minion      ][INFO    ][21956] Returning information for job: 20171210094846825836
2017-12-10 09:48:56,874 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094856850673
2017-12-10 09:48:56,885 [salt.minion      ][INFO    ][21961] Starting a new job with PID 21961
2017-12-10 09:48:56,895 [salt.minion      ][INFO    ][21961] Returning information for job: 20171210094856850673
2017-12-10 09:49:06,897 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094906880956
2017-12-10 09:49:06,907 [salt.minion      ][INFO    ][21966] Starting a new job with PID 21966
2017-12-10 09:49:06,917 [salt.minion      ][INFO    ][21966] Returning information for job: 20171210094906880956
2017-12-10 09:49:17,011 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094916992198
2017-12-10 09:49:17,021 [salt.minion      ][INFO    ][21971] Starting a new job with PID 21971
2017-12-10 09:49:17,031 [salt.minion      ][INFO    ][21971] Returning information for job: 20171210094916992198
2017-12-10 09:49:27,044 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094927028100
2017-12-10 09:49:27,054 [salt.minion      ][INFO    ][21976] Starting a new job with PID 21976
2017-12-10 09:49:27,064 [salt.minion      ][INFO    ][21976] Returning information for job: 20171210094927028100
2017-12-10 09:49:37,076 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094937060002
2017-12-10 09:49:37,086 [salt.minion      ][INFO    ][21981] Starting a new job with PID 21981
2017-12-10 09:49:37,096 [salt.minion      ][INFO    ][21981] Returning information for job: 20171210094937060002
2017-12-10 09:49:47,113 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094947096629
2017-12-10 09:49:47,124 [salt.minion      ][INFO    ][21986] Starting a new job with PID 21986
2017-12-10 09:49:47,134 [salt.minion      ][INFO    ][21986] Returning information for job: 20171210094947096629
2017-12-10 09:49:57,147 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210094957133052
2017-12-10 09:49:57,157 [salt.minion      ][INFO    ][21991] Starting a new job with PID 21991
2017-12-10 09:49:57,167 [salt.minion      ][INFO    ][21991] Returning information for job: 20171210094957133052
2017-12-10 09:50:07,186 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095007169407
2017-12-10 09:50:07,196 [salt.minion      ][INFO    ][21996] Starting a new job with PID 21996
2017-12-10 09:50:07,206 [salt.minion      ][INFO    ][21996] Returning information for job: 20171210095007169407
2017-12-10 09:50:18,088 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095018074160
2017-12-10 09:50:18,097 [salt.minion      ][INFO    ][22002] Starting a new job with PID 22002
2017-12-10 09:50:18,107 [salt.minion      ][INFO    ][22002] Returning information for job: 20171210095018074160
2017-12-10 09:50:28,138 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095028118449
2017-12-10 09:50:28,148 [salt.minion      ][INFO    ][22007] Starting a new job with PID 22007
2017-12-10 09:50:28,158 [salt.minion      ][INFO    ][22007] Returning information for job: 20171210095028118449
2017-12-10 09:50:38,187 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095038170332
2017-12-10 09:50:38,197 [salt.minion      ][INFO    ][22012] Starting a new job with PID 22012
2017-12-10 09:50:38,207 [salt.minion      ][INFO    ][22012] Returning information for job: 20171210095038170332
2017-12-10 09:50:48,244 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095048229883
2017-12-10 09:50:48,254 [salt.minion      ][INFO    ][22017] Starting a new job with PID 22017
2017-12-10 09:50:48,264 [salt.minion      ][INFO    ][22017] Returning information for job: 20171210095048229883
2017-12-10 09:50:58,305 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095058288962
2017-12-10 09:50:58,316 [salt.minion      ][INFO    ][22022] Starting a new job with PID 22022
2017-12-10 09:50:58,325 [salt.minion      ][INFO    ][22022] Returning information for job: 20171210095058288962
2017-12-10 09:51:08,366 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095108352621
2017-12-10 09:51:08,376 [salt.minion      ][INFO    ][22027] Starting a new job with PID 22027
2017-12-10 09:51:08,386 [salt.minion      ][INFO    ][22027] Returning information for job: 20171210095108352621
2017-12-10 09:51:18,426 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095118410962
2017-12-10 09:51:18,436 [salt.minion      ][INFO    ][22032] Starting a new job with PID 22032
2017-12-10 09:51:18,446 [salt.minion      ][INFO    ][22032] Returning information for job: 20171210095118410962
2017-12-10 09:51:28,450 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095128435324
2017-12-10 09:51:28,460 [salt.minion      ][INFO    ][22037] Starting a new job with PID 22037
2017-12-10 09:51:28,469 [salt.minion      ][INFO    ][22037] Returning information for job: 20171210095128435324
2017-12-10 09:51:38,510 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095138497560
2017-12-10 09:51:38,520 [salt.minion      ][INFO    ][22042] Starting a new job with PID 22042
2017-12-10 09:51:38,530 [salt.minion      ][INFO    ][22042] Returning information for job: 20171210095138497560
2017-12-10 09:51:48,585 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095148570231
2017-12-10 09:51:48,595 [salt.minion      ][INFO    ][22047] Starting a new job with PID 22047
2017-12-10 09:51:48,605 [salt.minion      ][INFO    ][22047] Returning information for job: 20171210095148570231
2017-12-10 09:51:58,664 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095158646787
2017-12-10 09:51:58,675 [salt.minion      ][INFO    ][22052] Starting a new job with PID 22052
2017-12-10 09:51:58,684 [salt.minion      ][INFO    ][22052] Returning information for job: 20171210095158646787
2017-12-10 09:52:08,759 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095208741458
2017-12-10 09:52:08,768 [salt.minion      ][INFO    ][22057] Starting a new job with PID 22057
2017-12-10 09:52:08,778 [salt.minion      ][INFO    ][22057] Returning information for job: 20171210095208741458
2017-12-10 09:52:18,859 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095218839941
2017-12-10 09:52:18,869 [salt.minion      ][INFO    ][22062] Starting a new job with PID 22062
2017-12-10 09:52:18,879 [salt.minion      ][INFO    ][22062] Returning information for job: 20171210095218839941
2017-12-10 09:52:28,939 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095228925085
2017-12-10 09:52:28,949 [salt.minion      ][INFO    ][22067] Starting a new job with PID 22067
2017-12-10 09:52:28,959 [salt.minion      ][INFO    ][22067] Returning information for job: 20171210095228925085
2017-12-10 09:52:39,047 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095239029330
2017-12-10 09:52:39,057 [salt.minion      ][INFO    ][22072] Starting a new job with PID 22072
2017-12-10 09:52:39,067 [salt.minion      ][INFO    ][22072] Returning information for job: 20171210095239029330
2017-12-10 09:52:49,153 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095249140013
2017-12-10 09:52:49,164 [salt.minion      ][INFO    ][22077] Starting a new job with PID 22077
2017-12-10 09:52:49,174 [salt.minion      ][INFO    ][22077] Returning information for job: 20171210095249140013
2017-12-10 09:52:59,247 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095259233170
2017-12-10 09:52:59,257 [salt.minion      ][INFO    ][22082] Starting a new job with PID 22082
2017-12-10 09:52:59,268 [salt.minion      ][INFO    ][22082] Returning information for job: 20171210095259233170
2017-12-10 09:53:09,441 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095309425953
2017-12-10 09:53:09,451 [salt.minion      ][INFO    ][22088] Starting a new job with PID 22088
2017-12-10 09:53:09,461 [salt.minion      ][INFO    ][22088] Returning information for job: 20171210095309425953
2017-12-10 09:53:19,546 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095319530827
2017-12-10 09:53:19,555 [salt.minion      ][INFO    ][22093] Starting a new job with PID 22093
2017-12-10 09:53:19,566 [salt.minion      ][INFO    ][22093] Returning information for job: 20171210095319530827
2017-12-10 09:53:29,710 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095329693510
2017-12-10 09:53:29,721 [salt.minion      ][INFO    ][22098] Starting a new job with PID 22098
2017-12-10 09:53:29,731 [salt.minion      ][INFO    ][22098] Returning information for job: 20171210095329693510
2017-12-10 09:53:39,842 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095339828450
2017-12-10 09:53:39,852 [salt.minion      ][INFO    ][22113] Starting a new job with PID 22113
2017-12-10 09:53:39,862 [salt.minion      ][INFO    ][22113] Returning information for job: 20171210095339828450
2017-12-10 09:53:49,894 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095349876993
2017-12-10 09:53:49,905 [salt.minion      ][INFO    ][22118] Starting a new job with PID 22118
2017-12-10 09:53:49,915 [salt.minion      ][INFO    ][22118] Returning information for job: 20171210095349876993
2017-12-10 09:54:00,006 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095359992195
2017-12-10 09:54:00,016 [salt.minion      ][INFO    ][22123] Starting a new job with PID 22123
2017-12-10 09:54:00,026 [salt.minion      ][INFO    ][22123] Returning information for job: 20171210095359992195
2017-12-10 09:54:10,126 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095410112723
2017-12-10 09:54:10,136 [salt.minion      ][INFO    ][22128] Starting a new job with PID 22128
2017-12-10 09:54:10,147 [salt.minion      ][INFO    ][22128] Returning information for job: 20171210095410112723
2017-12-10 09:54:13,678 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-10 09:54:13,699 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:13,712 [salt.loaded.int.module.cmdmod][ERROR   ][16199] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-10 09:54:13,712 [salt.loaded.int.module.cmdmod][ERROR   ][16199] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-10 09:54:13,713 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/mdb03.baremetal-mcp-ocata-odl-ha.local/system.qcow2' in directory '/root'
2017-12-10 09:54:13,731 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:13,740 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-10 09:54:14,802 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-10 09:54:15,569 [salt.loaded.ext.module.seedng][INFO    ][16199] salt-minion pre-installed on image, configuring as mdb03.baremetal-mcp-ocata-odl-ha.local
2017-12-10 09:54:15,574 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'mount -l' in directory '/root'
2017-12-10 09:54:15,588 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-10 09:54:15,678 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:17,237 [salt.state       ][INFO    ][16199] {'ret': True}
2017-12-10 09:54:17,238 [salt.state       ][INFO    ][16199] Completed state [virtng.init] at time 09:54:17.237829 duration_in_ms=416276.275
2017-12-10 09:54:17,238 [salt.state       ][INFO    ][16199] Running state [virt.set_autostart] at time 09:54:17.238113
2017-12-10 09:54:17,238 [salt.state       ][INFO    ][16199] Executing state module.run for virt.set_autostart
2017-12-10 09:54:17,241 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:54:17,264 [salt.state       ][INFO    ][16199] {'ret': True}
2017-12-10 09:54:17,264 [salt.state       ][INFO    ][16199] Completed state [virt.set_autostart] at time 09:54:17.263866 duration_in_ms=25.752
2017-12-10 09:54:17,264 [salt.state       ][INFO    ][16199] Running state [virtng.init] at time 09:54:17.264132
2017-12-10 09:54:17,264 [salt.state       ][INFO    ][16199] Executing state module.run for virtng.init
2017-12-10 09:54:17,267 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:54:18,255 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-10 09:54:18,263 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:18,272 [salt.loaded.int.module.cmdmod][ERROR   ][16199] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-10 09:54:18,272 [salt.loaded.int.module.cmdmod][ERROR   ][16199] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-10 09:54:18,272 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/dbs03.baremetal-mcp-ocata-odl-ha.local/system.qcow2' in directory '/root'
2017-12-10 09:54:18,289 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:18,298 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-10 09:54:19,333 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-10 09:54:19,981 [salt.loaded.ext.module.seedng][INFO    ][16199] salt-minion pre-installed on image, configuring as dbs03.baremetal-mcp-ocata-odl-ha.local
2017-12-10 09:54:19,987 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'mount -l' in directory '/root'
2017-12-10 09:54:20,001 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-10 09:54:20,075 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:20,259 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095420243121
2017-12-10 09:54:20,270 [salt.minion      ][INFO    ][22583] Starting a new job with PID 22583
2017-12-10 09:54:20,281 [salt.minion      ][INFO    ][22583] Returning information for job: 20171210095420243121
2017-12-10 09:54:21,661 [salt.state       ][INFO    ][16199] {'ret': True}
2017-12-10 09:54:21,661 [salt.state       ][INFO    ][16199] Completed state [virtng.init] at time 09:54:21.661323 duration_in_ms=4397.191
2017-12-10 09:54:21,662 [salt.state       ][INFO    ][16199] Running state [virt.set_autostart] at time 09:54:21.661637
2017-12-10 09:54:21,662 [salt.state       ][INFO    ][16199] Executing state module.run for virt.set_autostart
2017-12-10 09:54:21,665 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:54:21,687 [salt.state       ][INFO    ][16199] {'ret': True}
2017-12-10 09:54:21,687 [salt.state       ][INFO    ][16199] Completed state [virt.set_autostart] at time 09:54:21.686839 duration_in_ms=25.201
2017-12-10 09:54:21,687 [salt.state       ][INFO    ][16199] Running state [virtng.init] at time 09:54:21.687109
2017-12-10 09:54:21,687 [salt.state       ][INFO    ][16199] Executing state module.run for virtng.init
2017-12-10 09:54:21,690 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:54:22,660 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-10 09:54:22,670 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:22,678 [salt.loaded.int.module.cmdmod][ERROR   ][16199] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-10 09:54:22,678 [salt.loaded.int.module.cmdmod][ERROR   ][16199] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-10 09:54:22,678 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/prx02.baremetal-mcp-ocata-odl-ha.local/system.qcow2' in directory '/root'
2017-12-10 09:54:22,696 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:22,705 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-10 09:54:23,741 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-10 09:54:24,445 [salt.loaded.ext.module.seedng][INFO    ][16199] salt-minion pre-installed on image, configuring as prx02.baremetal-mcp-ocata-odl-ha.local
2017-12-10 09:54:24,450 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'mount -l' in directory '/root'
2017-12-10 09:54:24,464 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-10 09:54:24,534 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:26,575 [salt.state       ][INFO    ][16199] {'ret': True}
2017-12-10 09:54:26,576 [salt.state       ][INFO    ][16199] Completed state [virtng.init] at time 09:54:26.575754 duration_in_ms=4888.644
2017-12-10 09:54:26,576 [salt.state       ][INFO    ][16199] Running state [virt.set_autostart] at time 09:54:26.576086
2017-12-10 09:54:26,576 [salt.state       ][INFO    ][16199] Executing state module.run for virt.set_autostart
2017-12-10 09:54:26,579 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:54:26,601 [salt.state       ][INFO    ][16199] {'ret': True}
2017-12-10 09:54:26,602 [salt.state       ][INFO    ][16199] Completed state [virt.set_autostart] at time 09:54:26.601654 duration_in_ms=25.567
2017-12-10 09:54:26,602 [salt.state       ][INFO    ][16199] Running state [virtng.init] at time 09:54:26.601918
2017-12-10 09:54:26,602 [salt.state       ][INFO    ][16199] Executing state module.run for virtng.init
2017-12-10 09:54:26,605 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'virsh list --all --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:54:27,586 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-10 09:54:27,595 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:27,603 [salt.loaded.int.module.cmdmod][ERROR   ][16199] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-10 09:54:27,604 [salt.loaded.int.module.cmdmod][ERROR   ][16199] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-10 09:54:27,604 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/odl01.baremetal-mcp-ocata-odl-ha.local/system.qcow2' in directory '/root'
2017-12-10 09:54:27,621 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:27,630 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-10 09:54:28,685 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-10 09:54:29,349 [salt.loaded.ext.module.seedng][INFO    ][16199] salt-minion pre-installed on image, configuring as odl01.baremetal-mcp-ocata-odl-ha.local
2017-12-10 09:54:29,355 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'mount -l' in directory '/root'
2017-12-10 09:54:29,369 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-10 09:54:29,434 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:30,426 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210095430407813
2017-12-10 09:54:30,437 [salt.minion      ][INFO    ][23417] Starting a new job with PID 23417
2017-12-10 09:54:30,448 [salt.minion      ][INFO    ][23417] Returning information for job: 20171210095430407813
2017-12-10 09:54:31,053 [salt.state       ][INFO    ][16199] {'ret': True}
2017-12-10 09:54:31,053 [salt.state       ][INFO    ][16199] Completed state [virtng.init] at time 09:54:31.053430 duration_in_ms=4451.512
2017-12-10 09:54:31,054 [salt.state       ][INFO    ][16199] Running state [virt.set_autostart] at time 09:54:31.053705
2017-12-10 09:54:31,054 [salt.state       ][INFO    ][16199] Executing state module.run for virt.set_autostart
2017-12-10 09:54:31,057 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'virsh list --autostart --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:54:31,082 [salt.state       ][INFO    ][16199] {'ret': True}
2017-12-10 09:54:31,082 [salt.state       ][INFO    ][16199] Completed state [virt.set_autostart] at time 09:54:31.082176 duration_in_ms=28.47
2017-12-10 09:54:31,082 [salt.state       ][INFO    ][16199] Running state [virtng.init] at time 09:54:31.082465
2017-12-10 09:54:31,083 [salt.state       ][INFO    ][16199] Executing state module.run for virtng.init
2017-12-10 09:54:31,085 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:54:32,046 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-10 09:54:32,055 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:32,063 [salt.loaded.int.module.cmdmod][ERROR   ][16199] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-10 09:54:32,064 [salt.loaded.int.module.cmdmod][ERROR   ][16199] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-10 09:54:32,064 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/msg03.baremetal-mcp-ocata-odl-ha.local/system.qcow2' in directory '/root'
2017-12-10 09:54:32,081 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:32,090 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-10 09:54:33,122 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-10 09:54:33,831 [salt.loaded.ext.module.seedng][INFO    ][16199] salt-minion pre-installed on image, configuring as msg03.baremetal-mcp-ocata-odl-ha.local
2017-12-10 09:54:33,838 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'mount -l' in directory '/root'
2017-12-10 09:54:33,854 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-10 09:54:33,919 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:35,512 [salt.state       ][INFO    ][16199] {'ret': True}
2017-12-10 09:54:35,513 [salt.state       ][INFO    ][16199] Completed state [virtng.init] at time 09:54:35.512583 duration_in_ms=4430.118
2017-12-10 09:54:35,513 [salt.state       ][INFO    ][16199] Running state [virt.set_autostart] at time 09:54:35.512900
2017-12-10 09:54:35,513 [salt.state       ][INFO    ][16199] Executing state module.run for virt.set_autostart
2017-12-10 09:54:35,516 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:54:35,542 [salt.state       ][INFO    ][16199] {'ret': True}
2017-12-10 09:54:35,542 [salt.state       ][INFO    ][16199] Completed state [virt.set_autostart] at time 09:54:35.541890 duration_in_ms=28.989
2017-12-10 09:54:35,542 [salt.state       ][INFO    ][16199] Running state [virtng.init] at time 09:54:35.542136
2017-12-10 09:54:35,542 [salt.state       ][INFO    ][16199] Executing state module.run for virtng.init
2017-12-10 09:54:35,545 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:54:36,528 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-10 09:54:36,538 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:36,546 [salt.loaded.int.module.cmdmod][ERROR   ][16199] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-10 09:54:36,547 [salt.loaded.int.module.cmdmod][ERROR   ][16199] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-10 09:54:36,547 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/ctl03.baremetal-mcp-ocata-odl-ha.local/system.qcow2' in directory '/root'
2017-12-10 09:54:36,565 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:36,575 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-10 09:54:37,622 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-10 09:54:38,388 [salt.loaded.ext.module.seedng][INFO    ][16199] salt-minion pre-installed on image, configuring as ctl03.baremetal-mcp-ocata-odl-ha.local
2017-12-10 09:54:38,395 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'mount -l' in directory '/root'
2017-12-10 09:54:38,410 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-10 09:54:38,474 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-10 09:54:40,057 [salt.state       ][INFO    ][16199] {'ret': True}
2017-12-10 09:54:40,057 [salt.state       ][INFO    ][16199] Completed state [virtng.init] at time 09:54:40.057236 duration_in_ms=4515.099
2017-12-10 09:54:40,058 [salt.state       ][INFO    ][16199] Running state [virt.set_autostart] at time 09:54:40.057525
2017-12-10 09:54:40,058 [salt.state       ][INFO    ][16199] Executing state module.run for virt.set_autostart
2017-12-10 09:54:40,061 [salt.loaded.int.module.cmdmod][INFO    ][16199] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:54:40,084 [salt.state       ][INFO    ][16199] {'ret': True}
2017-12-10 09:54:40,084 [salt.state       ][INFO    ][16199] Completed state [virt.set_autostart] at time 09:54:40.084431 duration_in_ms=26.905
2017-12-10 09:54:40,089 [salt.minion      ][INFO    ][16199] Returning information for job: 20171210094705774601
2017-12-10 09:54:52,121 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command state.sls with jid 20171210095452107520
2017-12-10 09:54:52,132 [salt.minion      ][INFO    ][24012] Starting a new job with PID 24012
2017-12-10 09:54:54,440 [salt.state       ][INFO    ][24012] Loading fresh modules for state activity
2017-12-10 09:54:54,473 [salt.fileclient  ][INFO    ][24012] Fetching file from saltenv 'base', ** done ** 'libvirt/init.sls'
2017-12-10 09:54:54,498 [salt.fileclient  ][INFO    ][24012] Fetching file from saltenv 'base', ** done ** 'libvirt/server/init.sls'
2017-12-10 09:54:54,514 [salt.fileclient  ][INFO    ][24012] Fetching file from saltenv 'base', ** done ** 'libvirt/server/service.sls'
2017-12-10 09:54:54,535 [salt.fileclient  ][INFO    ][24012] Fetching file from saltenv 'base', ** done ** 'libvirt/map.jinja'
2017-12-10 09:54:54,590 [salt.fileclient  ][INFO    ][24012] Fetching file from saltenv 'base', ** done ** 'libvirt/server/network.sls'
2017-12-10 09:54:54,614 [salt.fileclient  ][INFO    ][24012] Fetching file from saltenv 'base', ** done ** 'libvirt/map.jinja'
2017-12-10 09:54:54,633 [salt.fileclient  ][INFO    ][24012] Fetching file from saltenv 'base', ** done ** 'libvirt/server/pool.sls'
2017-12-10 09:54:54,653 [salt.fileclient  ][INFO    ][24012] Fetching file from saltenv 'base', ** done ** 'libvirt/map.jinja'
2017-12-10 09:54:54,963 [salt.state       ][INFO    ][24012] Running state [libvirt0] at time 09:54:54.962680
2017-12-10 09:54:54,963 [salt.state       ][INFO    ][24012] Executing state pkg.installed for libvirt0
2017-12-10 09:54:54,963 [salt.loaded.int.module.cmdmod][INFO    ][24012] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 09:54:55,250 [salt.state       ][INFO    ][24012] Package libvirt0 is already installed
2017-12-10 09:54:55,251 [salt.state       ][INFO    ][24012] Completed state [libvirt0] at time 09:54:55.250544 duration_in_ms=287.864
2017-12-10 09:54:55,251 [salt.state       ][INFO    ][24012] Running state [pm-utils] at time 09:54:55.250840
2017-12-10 09:54:55,251 [salt.state       ][INFO    ][24012] Executing state pkg.installed for pm-utils
2017-12-10 09:54:55,255 [salt.state       ][INFO    ][24012] Package pm-utils is already installed
2017-12-10 09:54:55,255 [salt.state       ][INFO    ][24012] Completed state [pm-utils] at time 09:54:55.255190 duration_in_ms=4.35
2017-12-10 09:54:55,255 [salt.state       ][INFO    ][24012] Running state [python-libvirt] at time 09:54:55.255421
2017-12-10 09:54:55,256 [salt.state       ][INFO    ][24012] Executing state pkg.installed for python-libvirt
2017-12-10 09:54:55,260 [salt.state       ][INFO    ][24012] Package python-libvirt is already installed
2017-12-10 09:54:55,260 [salt.state       ][INFO    ][24012] Completed state [python-libvirt] at time 09:54:55.259654 duration_in_ms=4.233
2017-12-10 09:54:55,260 [salt.state       ][INFO    ][24012] Running state [libvirt-bin] at time 09:54:55.259861
2017-12-10 09:54:55,260 [salt.state       ][INFO    ][24012] Executing state pkg.installed for libvirt-bin
2017-12-10 09:54:55,264 [salt.state       ][INFO    ][24012] Package libvirt-bin is already installed
2017-12-10 09:54:55,264 [salt.state       ][INFO    ][24012] Completed state [libvirt-bin] at time 09:54:55.264056 duration_in_ms=4.195
2017-12-10 09:54:55,264 [salt.state       ][INFO    ][24012] Running state [qemu-utils] at time 09:54:55.264267
2017-12-10 09:54:55,264 [salt.state       ][INFO    ][24012] Executing state pkg.installed for qemu-utils
2017-12-10 09:54:55,268 [salt.state       ][INFO    ][24012] Package qemu-utils is already installed
2017-12-10 09:54:55,269 [salt.state       ][INFO    ][24012] Completed state [qemu-utils] at time 09:54:55.268487 duration_in_ms=4.22
2017-12-10 09:54:55,269 [salt.state       ][INFO    ][24012] Running state [qemu-kvm] at time 09:54:55.268697
2017-12-10 09:54:55,269 [salt.state       ][INFO    ][24012] Executing state pkg.installed for qemu-kvm
2017-12-10 09:54:55,273 [salt.state       ][INFO    ][24012] Package qemu-kvm is already installed
2017-12-10 09:54:55,273 [salt.state       ][INFO    ][24012] Completed state [qemu-kvm] at time 09:54:55.272922 duration_in_ms=4.225
2017-12-10 09:54:55,275 [salt.state       ][INFO    ][24012] Running state [/etc/libvirt/libvirtd.conf] at time 09:54:55.274503
2017-12-10 09:54:55,275 [salt.state       ][INFO    ][24012] Executing state file.managed for /etc/libvirt/libvirtd.conf
2017-12-10 09:54:55,301 [salt.fileclient  ][INFO    ][24012] Fetching file from saltenv 'base', ** done ** 'libvirt/files/libvirtd.conf.Debian'
2017-12-10 09:54:55,307 [salt.state       ][INFO    ][24012] File /etc/libvirt/libvirtd.conf is in the correct state
2017-12-10 09:54:55,307 [salt.state       ][INFO    ][24012] Completed state [/etc/libvirt/libvirtd.conf] at time 09:54:55.307369 duration_in_ms=32.865
2017-12-10 09:54:55,308 [salt.state       ][INFO    ][24012] Running state [/etc/default/libvirt-bin] at time 09:54:55.307703
2017-12-10 09:54:55,308 [salt.state       ][INFO    ][24012] Executing state file.managed for /etc/default/libvirt-bin
2017-12-10 09:54:55,326 [salt.fileclient  ][INFO    ][24012] Fetching file from saltenv 'base', ** done ** 'libvirt/files/libvirt-bin'
2017-12-10 09:54:55,329 [salt.state       ][INFO    ][24012] File /etc/default/libvirt-bin is in the correct state
2017-12-10 09:54:55,329 [salt.state       ][INFO    ][24012] Completed state [/etc/default/libvirt-bin] at time 09:54:55.328899 duration_in_ms=21.196
2017-12-10 09:54:55,330 [salt.state       ][INFO    ][24012] Running state [service.systemctl_reload] at time 09:54:55.329701
2017-12-10 09:54:55,330 [salt.state       ][INFO    ][24012] Executing state module.wait for service.systemctl_reload
2017-12-10 09:54:55,330 [salt.state       ][INFO    ][24012] No changes made for service.systemctl_reload
2017-12-10 09:54:55,330 [salt.state       ][INFO    ][24012] Completed state [service.systemctl_reload] at time 09:54:55.330294 duration_in_ms=0.592
2017-12-10 09:54:55,332 [salt.state       ][INFO    ][24012] Running state [/etc/libvirt/qemu/networks/default.xml] at time 09:54:55.332034
2017-12-10 09:54:55,332 [salt.state       ][INFO    ][24012] Executing state file.absent for /etc/libvirt/qemu/networks/default.xml
2017-12-10 09:54:55,333 [salt.state       ][INFO    ][24012] File /etc/libvirt/qemu/networks/default.xml is not present
2017-12-10 09:54:55,333 [salt.state       ][INFO    ][24012] Completed state [/etc/libvirt/qemu/networks/default.xml] at time 09:54:55.332717 duration_in_ms=0.683
2017-12-10 09:54:55,333 [salt.state       ][INFO    ][24012] Running state [libvirt-bin] at time 09:54:55.333238
2017-12-10 09:54:55,333 [salt.state       ][INFO    ][24012] Executing state service.running for libvirt-bin
2017-12-10 09:54:55,334 [salt.loaded.int.module.cmdmod][INFO    ][24012] Executing command ['systemctl', 'status', 'libvirt-bin.service', '-n', '0'] in directory '/root'
2017-12-10 09:54:55,350 [salt.loaded.int.module.cmdmod][INFO    ][24012] Executing command ['systemctl', 'is-active', 'libvirt-bin.service'] in directory '/root'
2017-12-10 09:54:55,357 [salt.loaded.int.module.cmdmod][INFO    ][24012] Executing command ['systemctl', 'is-enabled', 'libvirt-bin.service'] in directory '/root'
2017-12-10 09:54:55,363 [salt.state       ][INFO    ][24012] The service libvirt-bin is already running
2017-12-10 09:54:55,364 [salt.state       ][INFO    ][24012] Completed state [libvirt-bin] at time 09:54:55.363672 duration_in_ms=30.432
2017-12-10 09:54:55,365 [salt.state       ][INFO    ][24012] Running state [virsh net-undefine default;virsh net-destroy default 2>&1 1>/dev/null] at time 09:54:55.364860
2017-12-10 09:54:55,365 [salt.state       ][INFO    ][24012] Executing state cmd.run for virsh net-undefine default;virsh net-destroy default 2>&1 1>/dev/null
2017-12-10 09:54:55,366 [salt.loaded.int.module.cmdmod][INFO    ][24012] Executing command 'virsh -q net-list --all | grep -Eq '^\s*default'' in directory '/root'
2017-12-10 09:54:55,382 [salt.state       ][INFO    ][24012] onlyif execution failed
2017-12-10 09:54:55,382 [salt.state       ][INFO    ][24012] Completed state [virsh net-undefine default;virsh net-destroy default 2>&1 1>/dev/null] at time 09:54:55.381979 duration_in_ms=17.119
2017-12-10 09:54:55,382 [salt.state       ][INFO    ][24012] Running state [virsh net-autostart default --disable] at time 09:54:55.382259
2017-12-10 09:54:55,383 [salt.state       ][INFO    ][24012] Executing state cmd.run for virsh net-autostart default --disable
2017-12-10 09:54:55,383 [salt.loaded.int.module.cmdmod][INFO    ][24012] Executing command 'virsh net-info default | grep -Eq '^Autostart:\s+yes'' in directory '/root'
2017-12-10 09:54:55,399 [salt.state       ][INFO    ][24012] onlyif execution failed
2017-12-10 09:54:55,399 [salt.state       ][INFO    ][24012] Completed state [virsh net-autostart default --disable] at time 09:54:55.399343 duration_in_ms=17.084
2017-12-10 09:54:55,400 [salt.state       ][INFO    ][24012] Running state [virsh net-destroy default] at time 09:54:55.399605
2017-12-10 09:54:55,400 [salt.state       ][INFO    ][24012] Executing state cmd.run for virsh net-destroy default
2017-12-10 09:54:55,400 [salt.loaded.int.module.cmdmod][INFO    ][24012] Executing command 'virsh -q net-list --all | grep -Eq '^\s*default\s+active'' in directory '/root'
2017-12-10 09:54:55,416 [salt.state       ][INFO    ][24012] onlyif execution failed
2017-12-10 09:54:55,416 [salt.state       ][INFO    ][24012] Completed state [virsh net-destroy default] at time 09:54:55.416146 duration_in_ms=16.541
2017-12-10 09:54:55,416 [salt.state       ][INFO    ][24012] Running state [echo 'No pool is defined'] at time 09:54:55.416430
2017-12-10 09:54:55,417 [salt.state       ][INFO    ][24012] Executing state cmd.run for echo 'No pool is defined'
2017-12-10 09:54:55,417 [salt.loaded.int.module.cmdmod][INFO    ][24012] Executing command 'echo 'No pool is defined'' in directory '/root'
2017-12-10 09:54:55,422 [salt.state       ][INFO    ][24012] {'pid': 24046, 'retcode': 0, 'stderr': '', 'stdout': 'No pool is defined'}
2017-12-10 09:54:55,422 [salt.state       ][INFO    ][24012] Completed state [echo 'No pool is defined'] at time 09:54:55.422414 duration_in_ms=5.971
2017-12-10 09:54:55,424 [salt.minion      ][INFO    ][24012] Returning information for job: 20171210095452107520
2017-12-10 09:55:25,941 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command state.apply with jid 20171210095525926811
2017-12-10 09:55:25,952 [salt.minion      ][INFO    ][24055] Starting a new job with PID 24055
2017-12-10 09:55:28,699 [salt.state       ][INFO    ][24055] Loading fresh modules for state activity
2017-12-10 09:55:28,725 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/init.sls'
2017-12-10 09:55:28,750 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-10 09:55:28,765 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-10 09:55:28,826 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:55:28,897 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-10 09:55:28,921 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 09:55:28,978 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-10 09:55:29,006 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-10 09:55:29,021 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-10 09:55:29,040 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-10 09:55:29,049 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-10 09:55:29,060 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-10 09:55:29,082 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-10 09:55:29,101 [py.warnings      ][WARNING ][24055] /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-12-10 09:55:29,101 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'salt-minion --version' in directory '/root'
2017-12-10 09:55:29,340 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'salt-minion --version' in directory '/root'
2017-12-10 09:55:29,600 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-10 09:55:29,622 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-10 09:55:29,636 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-10 09:55:29,650 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-10 09:55:29,693 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-10 09:55:29,709 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-10 09:55:29,733 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-10 09:55:29,746 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-10 09:55:29,768 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-10 09:55:29,809 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-10 09:55:29,878 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-10 09:55:29,905 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:55:29,974 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-10 09:55:29,996 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 09:55:30,053 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-10 09:55:30,081 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-10 09:55:30,098 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-10 09:55:30,119 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-10 09:55:30,127 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-10 09:55:30,137 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-10 09:55:30,159 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-10 09:55:30,177 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'salt-minion --version' in directory '/root'
2017-12-10 09:55:30,424 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'salt-minion --version' in directory '/root'
2017-12-10 09:55:30,681 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-10 09:55:30,702 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-10 09:55:30,715 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-10 09:55:30,728 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-10 09:55:30,773 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-10 09:55:30,790 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-10 09:55:30,816 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-10 09:55:30,830 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-10 09:55:30,850 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-10 09:55:30,889 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-10 09:55:30,969 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-10 09:55:31,043 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:55:31,113 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-10 09:55:31,132 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-10 09:55:31,183 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:55:31,544 [salt.state       ][INFO    ][24055] Running state [salt-minion] at time 09:55:31.543525
2017-12-10 09:55:31,544 [salt.state       ][INFO    ][24055] Executing state pkg.installed for salt-minion
2017-12-10 09:55:31,544 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 09:55:31,771 [salt.state       ][INFO    ][24055] Package salt-minion is already installed
2017-12-10 09:55:31,771 [salt.state       ][INFO    ][24055] Completed state [salt-minion] at time 09:55:31.771235 duration_in_ms=227.697
2017-12-10 09:55:31,772 [salt.state       ][INFO    ][24055] Running state [salt_minion_dependency_packages] at time 09:55:31.771537
2017-12-10 09:55:31,772 [salt.state       ][INFO    ][24055] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-10 09:55:31,775 [salt.state       ][INFO    ][24055] All specified packages are already installed
2017-12-10 09:55:31,776 [salt.state       ][INFO    ][24055] Completed state [salt_minion_dependency_packages] at time 09:55:31.775589 duration_in_ms=4.052
2017-12-10 09:55:31,777 [salt.state       ][INFO    ][24055] Running state [/etc/salt/minion.d/minion.conf] at time 09:55:31.777267
2017-12-10 09:55:31,778 [salt.state       ][INFO    ][24055] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-10 09:55:31,801 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-10 09:55:31,861 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:55:31,914 [salt.fileclient  ][INFO    ][24055] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 09:55:31,960 [salt.state       ][INFO    ][24055] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-10 09:55:31,960 [salt.state       ][INFO    ][24055] Completed state [/etc/salt/minion.d/minion.conf] at time 09:55:31.960413 duration_in_ms=183.146
2017-12-10 09:55:31,961 [salt.state       ][INFO    ][24055] Running state [/etc/salt/minion.d/_virt.conf] at time 09:55:31.960844
2017-12-10 09:55:31,961 [salt.state       ][INFO    ][24055] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-10 09:55:31,962 [salt.state       ][INFO    ][24055] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-10 09:55:31,962 [salt.state       ][INFO    ][24055] Completed state [/etc/salt/minion.d/_virt.conf] at time 09:55:31.961852 duration_in_ms=1.007
2017-12-10 09:55:31,964 [salt.state       ][INFO    ][24055] Running state [salt-minion] at time 09:55:31.963498
2017-12-10 09:55:31,964 [salt.state       ][INFO    ][24055] Executing state service.running for salt-minion
2017-12-10 09:55:31,964 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-10 09:55:31,979 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-10 09:55:31,987 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-10 09:55:31,994 [salt.state       ][INFO    ][24055] The service salt-minion is already running
2017-12-10 09:55:31,995 [salt.state       ][INFO    ][24055] Completed state [salt-minion] at time 09:55:31.994620 duration_in_ms=31.121
2017-12-10 09:55:31,996 [salt.state       ][INFO    ][24055] Running state [/etc/salt/grains.d] at time 09:55:31.996129
2017-12-10 09:55:31,996 [salt.state       ][INFO    ][24055] Executing state file.directory for /etc/salt/grains.d
2017-12-10 09:55:31,997 [salt.state       ][INFO    ][24055] Directory /etc/salt/grains.d is in the correct state
2017-12-10 09:55:31,997 [salt.state       ][INFO    ][24055] Completed state [/etc/salt/grains.d] at time 09:55:31.997187 duration_in_ms=1.057
2017-12-10 09:55:31,998 [salt.state       ][INFO    ][24055] Running state [/etc/salt/grains] at time 09:55:31.997753
2017-12-10 09:55:31,998 [salt.state       ][INFO    ][24055] Executing state file.managed for /etc/salt/grains
2017-12-10 09:55:31,998 [salt.state       ][INFO    ][24055] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-10 09:55:31,999 [salt.state       ][INFO    ][24055] Completed state [/etc/salt/grains] at time 09:55:31.998489 duration_in_ms=0.736
2017-12-10 09:55:31,999 [salt.state       ][INFO    ][24055] Running state [/etc/salt/grains.d/placeholder] at time 09:55:31.998871
2017-12-10 09:55:31,999 [salt.state       ][INFO    ][24055] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-10 09:55:31,999 [salt.state       ][INFO    ][24055] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-10 09:55:31,1000 [salt.state       ][INFO    ][24055] Completed state [/etc/salt/grains.d/placeholder] at time 09:55:31.999565 duration_in_ms=0.694
2017-12-10 09:55:31,1000 [salt.state       ][INFO    ][24055] Running state [/etc/salt/grains.d/sphinx] at time 09:55:31.999945
2017-12-10 09:55:32,000 [salt.state       ][INFO    ][24055] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-10 09:55:32,001 [salt.state       ][INFO    ][24055] File /etc/salt/grains.d/sphinx is in the correct state
2017-12-10 09:55:32,001 [salt.state       ][INFO    ][24055] Completed state [/etc/salt/grains.d/sphinx] at time 09:55:32.001068 duration_in_ms=1.123
2017-12-10 09:55:32,002 [salt.state       ][INFO    ][24055] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:55:32.001818
2017-12-10 09:55:32,002 [salt.state       ][INFO    ][24055] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:55:32,002 [salt.state       ][INFO    ][24055] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:55:32,002 [salt.state       ][INFO    ][24055] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:55:32.002390 duration_in_ms=0.572
2017-12-10 09:55:32,003 [salt.state       ][INFO    ][24055] Running state [/etc/salt/grains.d/dns_records] at time 09:55:32.002759
2017-12-10 09:55:32,003 [salt.state       ][INFO    ][24055] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-10 09:55:32,004 [salt.state       ][INFO    ][24055] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-10 09:55:32,004 [salt.state       ][INFO    ][24055] Completed state [/etc/salt/grains.d/dns_records] at time 09:55:32.003750 duration_in_ms=0.991
2017-12-10 09:55:32,005 [salt.state       ][INFO    ][24055] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:55:32.004588
2017-12-10 09:55:32,005 [salt.state       ][INFO    ][24055] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:55:32,005 [salt.state       ][INFO    ][24055] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:55:32,005 [salt.state       ][INFO    ][24055] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:55:32.005163 duration_in_ms=0.575
2017-12-10 09:55:32,006 [salt.state       ][INFO    ][24055] Running state [/etc/salt/grains.d/salt] at time 09:55:32.005533
2017-12-10 09:55:32,006 [salt.state       ][INFO    ][24055] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-10 09:55:32,006 [salt.state       ][INFO    ][24055] File /etc/salt/grains.d/salt is in the correct state
2017-12-10 09:55:32,007 [salt.state       ][INFO    ][24055] Completed state [/etc/salt/grains.d/salt] at time 09:55:32.006535 duration_in_ms=1.002
2017-12-10 09:55:32,007 [salt.state       ][INFO    ][24055] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:55:32.007270
2017-12-10 09:55:32,008 [salt.state       ][INFO    ][24055] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:55:32,008 [salt.state       ][INFO    ][24055] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:55:32,008 [salt.state       ][INFO    ][24055] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:55:32.007845 duration_in_ms=0.575
2017-12-10 09:55:32,009 [salt.state       ][INFO    ][24055] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:55:32.009436
2017-12-10 09:55:32,010 [salt.state       ][INFO    ][24055] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-10 09:55:32,010 [salt.state       ][INFO    ][24055] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-10 09:55:32,010 [salt.state       ][INFO    ][24055] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:55:32.010028 duration_in_ms=0.592
2017-12-10 09:55:32,011 [salt.state       ][INFO    ][24055] Running state [mine.update] at time 09:55:32.010561
2017-12-10 09:55:32,011 [salt.state       ][INFO    ][24055] Executing state module.wait for mine.update
2017-12-10 09:55:32,011 [salt.state       ][INFO    ][24055] No changes made for mine.update
2017-12-10 09:55:32,011 [salt.state       ][INFO    ][24055] Completed state [mine.update] at time 09:55:32.011084 duration_in_ms=0.523
2017-12-10 09:55:32,011 [salt.state       ][INFO    ][24055] Running state [ca-certificates] at time 09:55:32.011253
2017-12-10 09:55:32,011 [salt.state       ][INFO    ][24055] Executing state pkg.installed for ca-certificates
2017-12-10 09:55:32,015 [salt.state       ][INFO    ][24055] Package ca-certificates is already installed
2017-12-10 09:55:32,015 [salt.state       ][INFO    ][24055] Completed state [ca-certificates] at time 09:55:32.015412 duration_in_ms=4.159
2017-12-10 09:55:32,016 [salt.state       ][INFO    ][24055] Running state [update-ca-certificates] at time 09:55:32.015981
2017-12-10 09:55:32,016 [salt.state       ][INFO    ][24055] Executing state cmd.wait for update-ca-certificates
2017-12-10 09:55:32,016 [salt.state       ][INFO    ][24055] No changes made for update-ca-certificates
2017-12-10 09:55:32,017 [salt.state       ][INFO    ][24055] Completed state [update-ca-certificates] at time 09:55:32.016545 duration_in_ms=0.564
2017-12-10 09:55:32,017 [salt.state       ][INFO    ][24055] Running state [libvirt-dev] at time 09:55:32.016715
2017-12-10 09:55:32,017 [salt.state       ][INFO    ][24055] Executing state pkg.installed for libvirt-dev
2017-12-10 09:55:32,020 [salt.state       ][INFO    ][24055] Package libvirt-dev is already installed
2017-12-10 09:55:32,021 [salt.state       ][INFO    ][24055] Completed state [libvirt-dev] at time 09:55:32.020618 duration_in_ms=3.904
2017-12-10 09:55:32,021 [salt.state       ][INFO    ][24055] Running state [pkg-config] at time 09:55:32.020815
2017-12-10 09:55:32,021 [salt.state       ][INFO    ][24055] Executing state pkg.installed for pkg-config
2017-12-10 09:55:32,025 [salt.state       ][INFO    ][24055] Package pkg-config is already installed
2017-12-10 09:55:32,025 [salt.state       ][INFO    ][24055] Completed state [pkg-config] at time 09:55:32.024659 duration_in_ms=3.844
2017-12-10 09:55:32,025 [salt.state       ][INFO    ][24055] Running state [virtng.init] at time 09:55:32.024850
2017-12-10 09:55:32,025 [salt.state       ][INFO    ][24055] Executing state module.run for virtng.init
2017-12-10 09:55:32,102 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command ['git', '--version'] in directory '/root'
2017-12-10 09:55:32,144 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:55:32,161 [salt.state       ][INFO    ][24055] unless execution succeeded
2017-12-10 09:55:32,161 [salt.state       ][INFO    ][24055] Completed state [virtng.init] at time 09:55:32.161361 duration_in_ms=136.51
2017-12-10 09:55:32,162 [salt.state       ][INFO    ][24055] Running state [virt.set_autostart] at time 09:55:32.161676
2017-12-10 09:55:32,162 [salt.state       ][INFO    ][24055] Executing state module.run for virt.set_autostart
2017-12-10 09:55:32,165 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:55:32,180 [salt.state       ][INFO    ][24055] unless execution succeeded
2017-12-10 09:55:32,181 [salt.state       ][INFO    ][24055] Completed state [virt.set_autostart] at time 09:55:32.180664 duration_in_ms=18.986
2017-12-10 09:55:32,181 [salt.state       ][INFO    ][24055] Running state [virtng.init] at time 09:55:32.181031
2017-12-10 09:55:32,181 [salt.state       ][INFO    ][24055] Executing state module.run for virtng.init
2017-12-10 09:55:32,184 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:55:32,198 [salt.state       ][INFO    ][24055] unless execution succeeded
2017-12-10 09:55:32,199 [salt.state       ][INFO    ][24055] Completed state [virtng.init] at time 09:55:32.198590 duration_in_ms=17.558
2017-12-10 09:55:32,199 [salt.state       ][INFO    ][24055] Running state [virt.set_autostart] at time 09:55:32.198865
2017-12-10 09:55:32,199 [salt.state       ][INFO    ][24055] Executing state module.run for virt.set_autostart
2017-12-10 09:55:32,202 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:55:32,216 [salt.state       ][INFO    ][24055] unless execution succeeded
2017-12-10 09:55:32,216 [salt.state       ][INFO    ][24055] Completed state [virt.set_autostart] at time 09:55:32.216381 duration_in_ms=17.516
2017-12-10 09:55:32,217 [salt.state       ][INFO    ][24055] Running state [virtng.init] at time 09:55:32.216678
2017-12-10 09:55:32,217 [salt.state       ][INFO    ][24055] Executing state module.run for virtng.init
2017-12-10 09:55:32,220 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:55:32,234 [salt.state       ][INFO    ][24055] unless execution succeeded
2017-12-10 09:55:32,235 [salt.state       ][INFO    ][24055] Completed state [virtng.init] at time 09:55:32.234539 duration_in_ms=17.86
2017-12-10 09:55:32,235 [salt.state       ][INFO    ][24055] Running state [virt.set_autostart] at time 09:55:32.234813
2017-12-10 09:55:32,235 [salt.state       ][INFO    ][24055] Executing state module.run for virt.set_autostart
2017-12-10 09:55:32,238 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:55:32,252 [salt.state       ][INFO    ][24055] unless execution succeeded
2017-12-10 09:55:32,253 [salt.state       ][INFO    ][24055] Completed state [virt.set_autostart] at time 09:55:32.252579 duration_in_ms=17.766
2017-12-10 09:55:32,253 [salt.state       ][INFO    ][24055] Running state [virtng.init] at time 09:55:32.252868
2017-12-10 09:55:32,253 [salt.state       ][INFO    ][24055] Executing state module.run for virtng.init
2017-12-10 09:55:32,256 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'virsh list --all --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:55:32,270 [salt.state       ][INFO    ][24055] unless execution succeeded
2017-12-10 09:55:32,270 [salt.state       ][INFO    ][24055] Completed state [virtng.init] at time 09:55:32.270313 duration_in_ms=17.445
2017-12-10 09:55:32,271 [salt.state       ][INFO    ][24055] Running state [virt.set_autostart] at time 09:55:32.270580
2017-12-10 09:55:32,271 [salt.state       ][INFO    ][24055] Executing state module.run for virt.set_autostart
2017-12-10 09:55:32,273 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'virsh list --autostart --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:55:32,288 [salt.state       ][INFO    ][24055] unless execution succeeded
2017-12-10 09:55:32,288 [salt.state       ][INFO    ][24055] Completed state [virt.set_autostart] at time 09:55:32.287890 duration_in_ms=17.31
2017-12-10 09:55:32,288 [salt.state       ][INFO    ][24055] Running state [virtng.init] at time 09:55:32.288154
2017-12-10 09:55:32,288 [salt.state       ][INFO    ][24055] Executing state module.run for virtng.init
2017-12-10 09:55:32,291 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:55:32,305 [salt.state       ][INFO    ][24055] unless execution succeeded
2017-12-10 09:55:32,306 [salt.state       ][INFO    ][24055] Completed state [virtng.init] at time 09:55:32.305693 duration_in_ms=17.539
2017-12-10 09:55:32,306 [salt.state       ][INFO    ][24055] Running state [virt.set_autostart] at time 09:55:32.305959
2017-12-10 09:55:32,306 [salt.state       ][INFO    ][24055] Executing state module.run for virt.set_autostart
2017-12-10 09:55:32,309 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:55:32,325 [salt.state       ][INFO    ][24055] unless execution succeeded
2017-12-10 09:55:32,325 [salt.state       ][INFO    ][24055] Completed state [virt.set_autostart] at time 09:55:32.324948 duration_in_ms=18.989
2017-12-10 09:55:32,325 [salt.state       ][INFO    ][24055] Running state [virtng.init] at time 09:55:32.325198
2017-12-10 09:55:32,325 [salt.state       ][INFO    ][24055] Executing state module.run for virtng.init
2017-12-10 09:55:32,328 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:55:32,342 [salt.state       ][INFO    ][24055] unless execution succeeded
2017-12-10 09:55:32,342 [salt.state       ][INFO    ][24055] Completed state [virtng.init] at time 09:55:32.341960 duration_in_ms=16.761
2017-12-10 09:55:32,342 [salt.state       ][INFO    ][24055] Running state [virt.set_autostart] at time 09:55:32.342231
2017-12-10 09:55:32,342 [salt.state       ][INFO    ][24055] Executing state module.run for virt.set_autostart
2017-12-10 09:55:32,345 [salt.loaded.int.module.cmdmod][INFO    ][24055] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:55:32,360 [salt.state       ][INFO    ][24055] unless execution succeeded
2017-12-10 09:55:32,360 [salt.state       ][INFO    ][24055] Completed state [virt.set_autostart] at time 09:55:32.360026 duration_in_ms=17.794
2017-12-10 09:55:32,363 [salt.minion      ][INFO    ][24055] Returning information for job: 20171210095525926811
2017-12-10 09:59:22,798 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command state.sls with jid 20171210095922780834
2017-12-10 09:59:22,810 [salt.minion      ][INFO    ][24266] Starting a new job with PID 24266
2017-12-10 09:59:25,143 [salt.state       ][INFO    ][24266] Loading fresh modules for state activity
2017-12-10 09:59:25,178 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-10 09:59:25,231 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-10 09:59:25,262 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:59:25,350 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-10 09:59:25,366 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-10 09:59:25,396 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:59:25,460 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-10 09:59:25,479 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 09:59:25,535 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-10 09:59:25,560 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-10 09:59:25,573 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-10 09:59:25,593 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-10 09:59:25,602 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-10 09:59:25,614 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-10 09:59:25,636 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-10 09:59:25,654 [py.warnings      ][WARNING ][24266] /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-12-10 09:59:25,655 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'salt-minion --version' in directory '/root'
2017-12-10 09:59:25,899 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'salt-minion --version' in directory '/root'
2017-12-10 09:59:26,159 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-10 09:59:26,183 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-10 09:59:26,196 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-10 09:59:26,213 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-10 09:59:26,258 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-10 09:59:26,276 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-10 09:59:26,304 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-10 09:59:26,320 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-10 09:59:26,341 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-10 09:59:26,384 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-10 09:59:26,455 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-10 09:59:26,482 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:59:26,548 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-10 09:59:26,569 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 09:59:26,625 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-10 09:59:26,652 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-10 09:59:26,663 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-10 09:59:26,682 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-10 09:59:26,690 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-10 09:59:26,701 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-10 09:59:26,722 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-10 09:59:26,741 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'salt-minion --version' in directory '/root'
2017-12-10 09:59:26,986 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'salt-minion --version' in directory '/root'
2017-12-10 09:59:27,247 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-10 09:59:27,268 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-10 09:59:27,282 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-10 09:59:27,296 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-10 09:59:27,339 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-10 09:59:27,353 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-10 09:59:27,373 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-10 09:59:27,387 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-10 09:59:27,404 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-10 09:59:27,439 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-10 09:59:27,523 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-10 09:59:27,595 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:59:27,923 [salt.state       ][INFO    ][24266] Running state [salt-minion] at time 09:59:27.923346
2017-12-10 09:59:27,924 [salt.state       ][INFO    ][24266] Executing state pkg.installed for salt-minion
2017-12-10 09:59:27,924 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 09:59:28,169 [salt.state       ][INFO    ][24266] Package salt-minion is already installed
2017-12-10 09:59:28,169 [salt.state       ][INFO    ][24266] Completed state [salt-minion] at time 09:59:28.168843 duration_in_ms=245.497
2017-12-10 09:59:28,169 [salt.state       ][INFO    ][24266] Running state [salt_minion_dependency_packages] at time 09:59:28.169112
2017-12-10 09:59:28,169 [salt.state       ][INFO    ][24266] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-10 09:59:28,173 [salt.state       ][INFO    ][24266] All specified packages are already installed
2017-12-10 09:59:28,173 [salt.state       ][INFO    ][24266] Completed state [salt_minion_dependency_packages] at time 09:59:28.173231 duration_in_ms=4.119
2017-12-10 09:59:28,175 [salt.state       ][INFO    ][24266] Running state [/etc/salt/minion.d/minion.conf] at time 09:59:28.174865
2017-12-10 09:59:28,175 [salt.state       ][INFO    ][24266] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-10 09:59:28,198 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-10 09:59:28,256 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-10 09:59:28,311 [salt.fileclient  ][INFO    ][24266] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 09:59:28,358 [salt.state       ][INFO    ][24266] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-10 09:59:28,358 [salt.state       ][INFO    ][24266] Completed state [/etc/salt/minion.d/minion.conf] at time 09:59:28.357851 duration_in_ms=182.986
2017-12-10 09:59:28,358 [salt.state       ][INFO    ][24266] Running state [/etc/salt/minion.d/_virt.conf] at time 09:59:28.358231
2017-12-10 09:59:28,358 [salt.state       ][INFO    ][24266] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-10 09:59:28,359 [salt.state       ][INFO    ][24266] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-10 09:59:28,359 [salt.state       ][INFO    ][24266] Completed state [/etc/salt/minion.d/_virt.conf] at time 09:59:28.359282 duration_in_ms=1.051
2017-12-10 09:59:28,361 [salt.state       ][INFO    ][24266] Running state [salt-minion] at time 09:59:28.361016
2017-12-10 09:59:28,361 [salt.state       ][INFO    ][24266] Executing state service.running for salt-minion
2017-12-10 09:59:28,362 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-10 09:59:28,377 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-10 09:59:28,385 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-10 09:59:28,392 [salt.state       ][INFO    ][24266] The service salt-minion is already running
2017-12-10 09:59:28,392 [salt.state       ][INFO    ][24266] Completed state [salt-minion] at time 09:59:28.392445 duration_in_ms=31.429
2017-12-10 09:59:28,394 [salt.state       ][INFO    ][24266] Running state [/etc/salt/grains.d] at time 09:59:28.394068
2017-12-10 09:59:28,394 [salt.state       ][INFO    ][24266] Executing state file.directory for /etc/salt/grains.d
2017-12-10 09:59:28,395 [salt.state       ][INFO    ][24266] Directory /etc/salt/grains.d is in the correct state
2017-12-10 09:59:28,395 [salt.state       ][INFO    ][24266] Completed state [/etc/salt/grains.d] at time 09:59:28.395085 duration_in_ms=1.018
2017-12-10 09:59:28,396 [salt.state       ][INFO    ][24266] Running state [/etc/salt/grains] at time 09:59:28.395652
2017-12-10 09:59:28,396 [salt.state       ][INFO    ][24266] Executing state file.managed for /etc/salt/grains
2017-12-10 09:59:28,396 [salt.state       ][INFO    ][24266] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-10 09:59:28,396 [salt.state       ][INFO    ][24266] Completed state [/etc/salt/grains] at time 09:59:28.396397 duration_in_ms=0.745
2017-12-10 09:59:28,397 [salt.state       ][INFO    ][24266] Running state [/etc/salt/grains.d/placeholder] at time 09:59:28.396846
2017-12-10 09:59:28,397 [salt.state       ][INFO    ][24266] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-10 09:59:28,397 [salt.state       ][INFO    ][24266] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-10 09:59:28,398 [salt.state       ][INFO    ][24266] Completed state [/etc/salt/grains.d/placeholder] at time 09:59:28.397581 duration_in_ms=0.735
2017-12-10 09:59:28,398 [salt.state       ][INFO    ][24266] Running state [/etc/salt/grains.d/sphinx] at time 09:59:28.397947
2017-12-10 09:59:28,398 [salt.state       ][INFO    ][24266] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-10 09:59:28,399 [salt.state       ][INFO    ][24266] File /etc/salt/grains.d/sphinx is in the correct state
2017-12-10 09:59:28,399 [salt.state       ][INFO    ][24266] Completed state [/etc/salt/grains.d/sphinx] at time 09:59:28.399061 duration_in_ms=1.113
2017-12-10 09:59:28,400 [salt.state       ][INFO    ][24266] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:59:28.399803
2017-12-10 09:59:28,400 [salt.state       ][INFO    ][24266] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:59:28,400 [salt.state       ][INFO    ][24266] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:59:28,400 [salt.state       ][INFO    ][24266] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:59:28.400419 duration_in_ms=0.616
2017-12-10 09:59:28,401 [salt.state       ][INFO    ][24266] Running state [/etc/salt/grains.d/dns_records] at time 09:59:28.400849
2017-12-10 09:59:28,401 [salt.state       ][INFO    ][24266] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-10 09:59:28,402 [salt.state       ][INFO    ][24266] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-10 09:59:28,402 [salt.state       ][INFO    ][24266] Completed state [/etc/salt/grains.d/dns_records] at time 09:59:28.401841 duration_in_ms=0.992
2017-12-10 09:59:28,403 [salt.state       ][INFO    ][24266] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:59:28.402596
2017-12-10 09:59:28,403 [salt.state       ][INFO    ][24266] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:59:28,403 [salt.state       ][INFO    ][24266] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:59:28,403 [salt.state       ][INFO    ][24266] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:59:28.403173 duration_in_ms=0.578
2017-12-10 09:59:28,404 [salt.state       ][INFO    ][24266] Running state [/etc/salt/grains.d/salt] at time 09:59:28.403540
2017-12-10 09:59:28,404 [salt.state       ][INFO    ][24266] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-10 09:59:28,404 [salt.state       ][INFO    ][24266] File /etc/salt/grains.d/salt is in the correct state
2017-12-10 09:59:28,405 [salt.state       ][INFO    ][24266] Completed state [/etc/salt/grains.d/salt] at time 09:59:28.404586 duration_in_ms=1.046
2017-12-10 09:59:28,405 [salt.state       ][INFO    ][24266] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:59:28.405339
2017-12-10 09:59:28,406 [salt.state       ][INFO    ][24266] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:59:28,406 [salt.state       ][INFO    ][24266] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-10 09:59:28,406 [salt.state       ][INFO    ][24266] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:59:28.405907 duration_in_ms=0.568
2017-12-10 09:59:28,408 [salt.state       ][INFO    ][24266] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:59:28.407483
2017-12-10 09:59:28,408 [salt.state       ][INFO    ][24266] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-10 09:59:28,408 [salt.state       ][INFO    ][24266] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-10 09:59:28,408 [salt.state       ][INFO    ][24266] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:59:28.408080 duration_in_ms=0.598
2017-12-10 09:59:28,409 [salt.state       ][INFO    ][24266] Running state [mine.update] at time 09:59:28.408658
2017-12-10 09:59:28,409 [salt.state       ][INFO    ][24266] Executing state module.wait for mine.update
2017-12-10 09:59:28,409 [salt.state       ][INFO    ][24266] No changes made for mine.update
2017-12-10 09:59:28,409 [salt.state       ][INFO    ][24266] Completed state [mine.update] at time 09:59:28.409235 duration_in_ms=0.578
2017-12-10 09:59:28,409 [salt.state       ][INFO    ][24266] Running state [ca-certificates] at time 09:59:28.409414
2017-12-10 09:59:28,410 [salt.state       ][INFO    ][24266] Executing state pkg.installed for ca-certificates
2017-12-10 09:59:28,414 [salt.state       ][INFO    ][24266] Package ca-certificates is already installed
2017-12-10 09:59:28,414 [salt.state       ][INFO    ][24266] Completed state [ca-certificates] at time 09:59:28.413657 duration_in_ms=4.243
2017-12-10 09:59:28,414 [salt.state       ][INFO    ][24266] Running state [update-ca-certificates] at time 09:59:28.414227
2017-12-10 09:59:28,414 [salt.state       ][INFO    ][24266] Executing state cmd.wait for update-ca-certificates
2017-12-10 09:59:28,415 [salt.state       ][INFO    ][24266] No changes made for update-ca-certificates
2017-12-10 09:59:28,415 [salt.state       ][INFO    ][24266] Completed state [update-ca-certificates] at time 09:59:28.414806 duration_in_ms=0.578
2017-12-10 09:59:28,415 [salt.state       ][INFO    ][24266] Running state [libvirt-dev] at time 09:59:28.414989
2017-12-10 09:59:28,415 [salt.state       ][INFO    ][24266] Executing state pkg.installed for libvirt-dev
2017-12-10 09:59:28,419 [salt.state       ][INFO    ][24266] Package libvirt-dev is already installed
2017-12-10 09:59:28,419 [salt.state       ][INFO    ][24266] Completed state [libvirt-dev] at time 09:59:28.418860 duration_in_ms=3.871
2017-12-10 09:59:28,419 [salt.state       ][INFO    ][24266] Running state [pkg-config] at time 09:59:28.419046
2017-12-10 09:59:28,419 [salt.state       ][INFO    ][24266] Executing state pkg.installed for pkg-config
2017-12-10 09:59:28,423 [salt.state       ][INFO    ][24266] Package pkg-config is already installed
2017-12-10 09:59:28,423 [salt.state       ][INFO    ][24266] Completed state [pkg-config] at time 09:59:28.422964 duration_in_ms=3.918
2017-12-10 09:59:28,423 [salt.state       ][INFO    ][24266] Running state [virtng.init] at time 09:59:28.423153
2017-12-10 09:59:28,423 [salt.state       ][INFO    ][24266] Executing state module.run for virtng.init
2017-12-10 09:59:28,498 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command ['git', '--version'] in directory '/root'
2017-12-10 09:59:28,539 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:59:28,556 [salt.state       ][INFO    ][24266] unless execution succeeded
2017-12-10 09:59:28,556 [salt.state       ][INFO    ][24266] Completed state [virtng.init] at time 09:59:28.555887 duration_in_ms=132.733
2017-12-10 09:59:28,556 [salt.state       ][INFO    ][24266] Running state [virt.set_autostart] at time 09:59:28.556135
2017-12-10 09:59:28,556 [salt.state       ][INFO    ][24266] Executing state module.run for virt.set_autostart
2017-12-10 09:59:28,559 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:59:28,576 [salt.state       ][INFO    ][24266] unless execution succeeded
2017-12-10 09:59:28,576 [salt.state       ][INFO    ][24266] Completed state [virt.set_autostart] at time 09:59:28.575785 duration_in_ms=19.649
2017-12-10 09:59:28,576 [salt.state       ][INFO    ][24266] Running state [virtng.init] at time 09:59:28.576061
2017-12-10 09:59:28,576 [salt.state       ][INFO    ][24266] Executing state module.run for virtng.init
2017-12-10 09:59:28,579 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:59:28,594 [salt.state       ][INFO    ][24266] unless execution succeeded
2017-12-10 09:59:28,595 [salt.state       ][INFO    ][24266] Completed state [virtng.init] at time 09:59:28.594498 duration_in_ms=18.437
2017-12-10 09:59:28,595 [salt.state       ][INFO    ][24266] Running state [virt.set_autostart] at time 09:59:28.594738
2017-12-10 09:59:28,595 [salt.state       ][INFO    ][24266] Executing state module.run for virt.set_autostart
2017-12-10 09:59:28,598 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:59:28,614 [salt.state       ][INFO    ][24266] unless execution succeeded
2017-12-10 09:59:28,614 [salt.state       ][INFO    ][24266] Completed state [virt.set_autostart] at time 09:59:28.614314 duration_in_ms=19.576
2017-12-10 09:59:28,615 [salt.state       ][INFO    ][24266] Running state [virtng.init] at time 09:59:28.614556
2017-12-10 09:59:28,615 [salt.state       ][INFO    ][24266] Executing state module.run for virtng.init
2017-12-10 09:59:28,617 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:59:28,632 [salt.state       ][INFO    ][24266] unless execution succeeded
2017-12-10 09:59:28,633 [salt.state       ][INFO    ][24266] Completed state [virtng.init] at time 09:59:28.632649 duration_in_ms=18.093
2017-12-10 09:59:28,633 [salt.state       ][INFO    ][24266] Running state [virt.set_autostart] at time 09:59:28.632919
2017-12-10 09:59:28,633 [salt.state       ][INFO    ][24266] Executing state module.run for virt.set_autostart
2017-12-10 09:59:28,636 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:59:28,652 [salt.state       ][INFO    ][24266] unless execution succeeded
2017-12-10 09:59:28,652 [salt.state       ][INFO    ][24266] Completed state [virt.set_autostart] at time 09:59:28.651797 duration_in_ms=18.878
2017-12-10 09:59:28,652 [salt.state       ][INFO    ][24266] Running state [virtng.init] at time 09:59:28.652056
2017-12-10 09:59:28,652 [salt.state       ][INFO    ][24266] Executing state module.run for virtng.init
2017-12-10 09:59:28,655 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'virsh list --all --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:59:28,670 [salt.state       ][INFO    ][24266] unless execution succeeded
2017-12-10 09:59:28,670 [salt.state       ][INFO    ][24266] Completed state [virtng.init] at time 09:59:28.670112 duration_in_ms=18.056
2017-12-10 09:59:28,670 [salt.state       ][INFO    ][24266] Running state [virt.set_autostart] at time 09:59:28.670335
2017-12-10 09:59:28,671 [salt.state       ][INFO    ][24266] Executing state module.run for virt.set_autostart
2017-12-10 09:59:28,673 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'virsh list --autostart --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:59:28,689 [salt.state       ][INFO    ][24266] unless execution succeeded
2017-12-10 09:59:28,689 [salt.state       ][INFO    ][24266] Completed state [virt.set_autostart] at time 09:59:28.688976 duration_in_ms=18.641
2017-12-10 09:59:28,689 [salt.state       ][INFO    ][24266] Running state [virtng.init] at time 09:59:28.689241
2017-12-10 09:59:28,689 [salt.state       ][INFO    ][24266] Executing state module.run for virtng.init
2017-12-10 09:59:28,692 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:59:28,707 [salt.state       ][INFO    ][24266] unless execution succeeded
2017-12-10 09:59:28,707 [salt.state       ][INFO    ][24266] Completed state [virtng.init] at time 09:59:28.707272 duration_in_ms=18.031
2017-12-10 09:59:28,708 [salt.state       ][INFO    ][24266] Running state [virt.set_autostart] at time 09:59:28.707494
2017-12-10 09:59:28,708 [salt.state       ][INFO    ][24266] Executing state module.run for virt.set_autostart
2017-12-10 09:59:28,710 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:59:28,726 [salt.state       ][INFO    ][24266] unless execution succeeded
2017-12-10 09:59:28,727 [salt.state       ][INFO    ][24266] Completed state [virt.set_autostart] at time 09:59:28.726601 duration_in_ms=19.106
2017-12-10 09:59:28,727 [salt.state       ][INFO    ][24266] Running state [virtng.init] at time 09:59:28.726842
2017-12-10 09:59:28,727 [salt.state       ][INFO    ][24266] Executing state module.run for virtng.init
2017-12-10 09:59:28,730 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:59:28,744 [salt.state       ][INFO    ][24266] unless execution succeeded
2017-12-10 09:59:28,745 [salt.state       ][INFO    ][24266] Completed state [virtng.init] at time 09:59:28.744634 duration_in_ms=17.792
2017-12-10 09:59:28,745 [salt.state       ][INFO    ][24266] Running state [virt.set_autostart] at time 09:59:28.744877
2017-12-10 09:59:28,745 [salt.state       ][INFO    ][24266] Executing state module.run for virt.set_autostart
2017-12-10 09:59:28,747 [salt.loaded.int.module.cmdmod][INFO    ][24266] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-10 09:59:28,764 [salt.state       ][INFO    ][24266] unless execution succeeded
2017-12-10 09:59:28,764 [salt.state       ][INFO    ][24266] Completed state [virt.set_autostart] at time 09:59:28.763734 duration_in_ms=18.857
2017-12-10 09:59:28,767 [salt.minion      ][INFO    ][24266] Returning information for job: 20171210095922780834
2017-12-10 10:00:15,999 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171210100015983129
2017-12-10 10:00:16,014 [salt.minion      ][INFO    ][24417] Starting a new job with PID 24417
2017-12-10 10:00:20,502 [salt.state       ][INFO    ][24417] Loading fresh modules for state activity
2017-12-10 10:00:21,129 [salt.state       ][ERROR   ][24417] No contents found in top file
2017-12-10 10:00:21,130 [salt.utils.extmods][INFO    ][24417] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-10 10:00:21,133 [salt.utils.extmods][INFO    ][24417] Syncing beacons for environment 'base'
2017-12-10 10:00:21,133 [salt.utils.extmods][INFO    ][24417] Loading cache from salt://_beacons, for base)
2017-12-10 10:00:21,133 [salt.fileclient  ][INFO    ][24417] Caching directory '_beacons/' for environment 'base'
2017-12-10 10:00:21,190 [salt.utils.extmods][INFO    ][24417] Syncing modules for environment 'base'
2017-12-10 10:00:21,190 [salt.utils.extmods][INFO    ][24417] Loading cache from salt://_modules, for base)
2017-12-10 10:00:21,190 [salt.fileclient  ][INFO    ][24417] Caching directory '_modules/' for environment 'base'
2017-12-10 10:00:21,298 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-10 10:00:21,319 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-10 10:00:21,356 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-10 10:00:21,376 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-10 10:00:21,394 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-10 10:00:21,413 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-10 10:00:21,426 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-10 10:00:21,442 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-10 10:00:21,473 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-10 10:00:21,486 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-10 10:00:21,498 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-10 10:00:21,515 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-10 10:00:21,530 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-10 10:00:21,542 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-10 10:00:21,560 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-10 10:00:21,579 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-10 10:00:21,611 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-10 10:00:21,633 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-10 10:00:21,651 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-10 10:00:21,670 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-10 10:00:21,692 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-10 10:00:21,714 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-10 10:00:21,756 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-10 10:00:21,778 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-10 10:00:21,795 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-10 10:00:21,819 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-10 10:00:21,831 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-10 10:00:21,844 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-10 10:00:21,863 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-10 10:00:21,888 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-10 10:00:21,900 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-10 10:00:21,951 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-10 10:00:21,968 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-10 10:00:21,996 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-10 10:00:22,001 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-10 10:00:22,001 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-10 10:00:22,001 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-10 10:00:22,001 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-10 10:00:22,002 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-10 10:00:22,002 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-10 10:00:22,002 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-10 10:00:22,003 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-10 10:00:22,003 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-10 10:00:22,003 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-10 10:00:22,003 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-10 10:00:22,004 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-10 10:00:22,004 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-10 10:00:22,004 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-10 10:00:22,005 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-10 10:00:22,005 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-10 10:00:22,005 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-10 10:00:22,005 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-10 10:00:22,006 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-10 10:00:22,006 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-10 10:00:22,006 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-10 10:00:22,006 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-10 10:00:22,007 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-10 10:00:22,007 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-10 10:00:22,007 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-10 10:00:22,008 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-10 10:00:22,008 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-10 10:00:22,008 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-10 10:00:22,009 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-10 10:00:22,009 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-10 10:00:22,009 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-10 10:00:22,009 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-10 10:00:22,010 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-10 10:00:22,010 [salt.utils.extmods][INFO    ][24417] 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-12-10 10:00:22,010 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-10 10:00:22,010 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-10 10:00:22,016 [salt.utils.extmods][INFO    ][24417] Syncing states for environment 'base'
2017-12-10 10:00:22,016 [salt.utils.extmods][INFO    ][24417] Loading cache from salt://_states, for base)
2017-12-10 10:00:22,017 [salt.fileclient  ][INFO    ][24417] Caching directory '_states/' for environment 'base'
2017-12-10 10:00:22,124 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-10 10:00:22,139 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-10 10:00:22,152 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-10 10:00:22,170 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-10 10:00:22,193 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-10 10:00:22,205 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-10 10:00:22,216 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-10 10:00:22,230 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-10 10:00:22,248 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-10 10:00:22,261 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-10 10:00:22,270 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-10 10:00:22,283 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-10 10:00:22,311 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-10 10:00:22,324 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-10 10:00:22,356 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-10 10:00:22,376 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-10 10:00:22,409 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-10 10:00:22,421 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-10 10:00:22,444 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-10 10:00:22,475 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-10 10:00:22,487 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-10 10:00:22,506 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-10 10:00:22,520 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-10 10:00:22,530 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-10 10:00:22,542 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-10 10:00:22,560 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-10 10:00:22,579 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-10 10:00:22,598 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-10 10:00:22,686 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-10 10:00:22,698 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-10 10:00:22,710 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-10 10:00:22,735 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-10 10:00:22,739 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-10 10:00:22,739 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-10 10:00:22,740 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-10 10:00:22,740 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-10 10:00:22,740 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-10 10:00:22,740 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-10 10:00:22,741 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-10 10:00:22,741 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-10 10:00:22,741 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-10 10:00:22,742 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-10 10:00:22,742 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-10 10:00:22,742 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-10 10:00:22,742 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-10 10:00:22,743 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-10 10:00:22,743 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-10 10:00:22,743 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-10 10:00:22,743 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-10 10:00:22,744 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-10 10:00:22,744 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-10 10:00:22,744 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-10 10:00:22,744 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-10 10:00:22,745 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-10 10:00:22,745 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-10 10:00:22,745 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-10 10:00:22,745 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-10 10:00:22,746 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-10 10:00:22,746 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-10 10:00:22,746 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-10 10:00:22,746 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-10 10:00:22,747 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-10 10:00:22,747 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-10 10:00:22,747 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-10 10:00:22,747 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-10 10:00:22,750 [salt.utils.extmods][INFO    ][24417] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-10 10:00:22,754 [salt.utils.extmods][INFO    ][24417] Syncing sdb for environment 'base'
2017-12-10 10:00:22,754 [salt.utils.extmods][INFO    ][24417] Loading cache from salt://_sdb, for base)
2017-12-10 10:00:22,754 [salt.fileclient  ][INFO    ][24417] Caching directory '_sdb/' for environment 'base'
2017-12-10 10:00:22,843 [salt.utils.extmods][INFO    ][24417] Syncing grains for environment 'base'
2017-12-10 10:00:22,843 [salt.utils.extmods][INFO    ][24417] Loading cache from salt://_grains, for base)
2017-12-10 10:00:22,844 [salt.fileclient  ][INFO    ][24417] Caching directory '_grains/' for environment 'base'
2017-12-10 10:00:22,931 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-10 10:00:22,949 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-10 10:00:22,974 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-10 10:00:22,988 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-10 10:00:22,999 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-10 10:00:23,035 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-10 10:00:23,047 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-10 10:00:23,071 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-10 10:00:23,105 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-10 10:00:23,120 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-10 10:00:23,133 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-10 10:00:23,142 [salt.fileclient  ][INFO    ][24417] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-10 10:00:23,146 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-10 10:00:23,146 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-10 10:00:23,147 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-10 10:00:23,147 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-10 10:00:23,147 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-10 10:00:23,147 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-10 10:00:23,148 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-10 10:00:23,148 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-10 10:00:23,148 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-10 10:00:23,148 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-10 10:00:23,149 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-10 10:00:23,149 [salt.utils.extmods][INFO    ][24417] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-10 10:00:23,150 [salt.utils.extmods][INFO    ][24417] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-10 10:00:23,153 [salt.utils.extmods][INFO    ][24417] Syncing renderers for environment 'base'
2017-12-10 10:00:23,153 [salt.utils.extmods][INFO    ][24417] Loading cache from salt://_renderers, for base)
2017-12-10 10:00:23,153 [salt.fileclient  ][INFO    ][24417] Caching directory '_renderers/' for environment 'base'
2017-12-10 10:00:23,243 [salt.utils.extmods][INFO    ][24417] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-10 10:00:23,246 [salt.utils.extmods][INFO    ][24417] Syncing returners for environment 'base'
2017-12-10 10:00:23,246 [salt.utils.extmods][INFO    ][24417] Loading cache from salt://_returners, for base)
2017-12-10 10:00:23,246 [salt.fileclient  ][INFO    ][24417] Caching directory '_returners/' for environment 'base'
2017-12-10 10:00:23,340 [salt.utils.extmods][INFO    ][24417] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-10 10:00:23,344 [salt.utils.extmods][INFO    ][24417] Syncing output for environment 'base'
2017-12-10 10:00:23,344 [salt.utils.extmods][INFO    ][24417] Loading cache from salt://_output, for base)
2017-12-10 10:00:23,344 [salt.fileclient  ][INFO    ][24417] Caching directory '_output/' for environment 'base'
2017-12-10 10:00:23,405 [salt.utils.extmods][INFO    ][24417] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-10 10:00:23,408 [salt.utils.extmods][INFO    ][24417] Syncing utils for environment 'base'
2017-12-10 10:00:23,408 [salt.utils.extmods][INFO    ][24417] Loading cache from salt://_utils, for base)
2017-12-10 10:00:23,409 [salt.fileclient  ][INFO    ][24417] Caching directory '_utils/' for environment 'base'
2017-12-10 10:00:23,442 [salt.utils.extmods][INFO    ][24417] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-10 10:00:23,445 [salt.utils.extmods][INFO    ][24417] Syncing log_handlers for environment 'base'
2017-12-10 10:00:23,445 [salt.utils.extmods][INFO    ][24417] Loading cache from salt://_log_handlers, for base)
2017-12-10 10:00:23,445 [salt.fileclient  ][INFO    ][24417] Caching directory '_log_handlers/' for environment 'base'
2017-12-10 10:00:23,498 [salt.utils.extmods][INFO    ][24417] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-10 10:00:23,501 [salt.utils.extmods][INFO    ][24417] Syncing proxy for environment 'base'
2017-12-10 10:00:23,501 [salt.utils.extmods][INFO    ][24417] Loading cache from salt://_proxy, for base)
2017-12-10 10:00:23,501 [salt.fileclient  ][INFO    ][24417] Caching directory '_proxy/' for environment 'base'
2017-12-10 10:00:23,576 [salt.utils.extmods][INFO    ][24417] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-10 10:00:23,579 [salt.utils.extmods][INFO    ][24417] Syncing engines for environment 'base'
2017-12-10 10:00:23,579 [salt.utils.extmods][INFO    ][24417] Loading cache from salt://_engines, for base)
2017-12-10 10:00:23,579 [salt.fileclient  ][INFO    ][24417] Caching directory '_engines/' for environment 'base'
2017-12-10 10:00:23,632 [salt.minion      ][INFO    ][24417] Returning information for job: 20171210100015983129
2017-12-10 10:14:38,966 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command test.ping with jid 20171210101438958364
2017-12-10 10:14:38,981 [salt.minion      ][INFO    ][24743] Starting a new job with PID 24743
2017-12-10 10:14:39,021 [salt.minion      ][INFO    ][24743] Returning information for job: 20171210101438958364
2017-12-10 10:14:54,160 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command state.sls with jid 20171210101454145216
2017-12-10 10:14:54,173 [salt.minion      ][INFO    ][24752] Starting a new job with PID 24752
2017-12-10 10:14:54,763 [salt.state       ][INFO    ][24752] Loading fresh modules for state activity
2017-12-10 10:14:54,796 [salt.fileclient  ][INFO    ][24752] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-10 10:14:54,818 [salt.fileclient  ][INFO    ][24752] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-10 10:14:54,853 [salt.fileclient  ][INFO    ][24752] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-10 10:14:55,258 [salt.state       ][INFO    ][24752] Running state [lsof] at time 10:14:55.257648
2017-12-10 10:14:55,258 [salt.state       ][INFO    ][24752] Executing state pkg.installed for lsof
2017-12-10 10:14:55,258 [salt.loaded.int.module.cmdmod][INFO    ][24752] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:14:55,589 [salt.state       ][INFO    ][24752] Package lsof is already installed
2017-12-10 10:14:55,589 [salt.state       ][INFO    ][24752] Completed state [lsof] at time 10:14:55.589242 duration_in_ms=331.594
2017-12-10 10:14:55,590 [salt.state       ][INFO    ][24752] Running state [keepalived] at time 10:14:55.589505
2017-12-10 10:14:55,590 [salt.state       ][INFO    ][24752] Executing state pkg.installed for keepalived
2017-12-10 10:14:55,608 [salt.loaded.int.module.cmdmod][INFO    ][24752] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-10 10:14:57,035 [salt.loaded.int.module.cmdmod][INFO    ][24752] 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-12-10 10:14:59,882 [salt.loaded.int.module.cmdmod][INFO    ][24752] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:14:59,910 [salt.state       ][INFO    ][24752] 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-12-10 10:14:59,920 [salt.state       ][INFO    ][24752] Loading fresh modules for state activity
2017-12-10 10:14:59,937 [salt.state       ][INFO    ][24752] Completed state [keepalived] at time 10:14:59.936729 duration_in_ms=4347.222
2017-12-10 10:14:59,940 [salt.state       ][INFO    ][24752] Running state [/etc/keepalived/keepalived.conf] at time 10:14:59.939711
2017-12-10 10:14:59,940 [salt.state       ][INFO    ][24752] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-10 10:14:59,974 [salt.fileclient  ][INFO    ][24752] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-10 10:15:00,018 [salt.fileclient  ][INFO    ][24752] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-10 10:15:00,027 [salt.state       ][INFO    ][24752] File changed:
New file
2017-12-10 10:15:00,027 [salt.state       ][INFO    ][24752] Completed state [/etc/keepalived/keepalived.conf] at time 10:15:00.027232 duration_in_ms=87.52
2017-12-10 10:15:00,099 [salt.state       ][INFO    ][24752] Running state [keepalived] at time 10:15:00.099049
2017-12-10 10:15:00,099 [salt.state       ][INFO    ][24752] Executing state service.running for keepalived
2017-12-10 10:15:00,101 [salt.loaded.int.module.cmdmod][INFO    ][24752] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-10 10:15:00,112 [salt.loaded.int.module.cmdmod][INFO    ][24752] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-10 10:15:00,120 [salt.loaded.int.module.cmdmod][INFO    ][24752] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-10 10:15:00,129 [salt.loaded.int.module.cmdmod][INFO    ][24752] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-10 10:15:00,137 [salt.loaded.int.module.cmdmod][INFO    ][24752] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-12-10 10:15:00,170 [salt.loaded.int.module.cmdmod][INFO    ][24752] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-10 10:15:00,180 [salt.loaded.int.module.cmdmod][INFO    ][24752] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-10 10:15:00,188 [salt.loaded.int.module.cmdmod][INFO    ][24752] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-10 10:15:00,196 [salt.state       ][INFO    ][24752] {'keepalived': True}
2017-12-10 10:15:00,196 [salt.state       ][INFO    ][24752] Completed state [keepalived] at time 10:15:00.196375 duration_in_ms=97.327
2017-12-10 10:15:00,197 [salt.minion      ][INFO    ][24752] Returning information for job: 20171210101454145216
2017-12-10 10:16:49,610 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command pillar.get with jid 20171210101649601951
2017-12-10 10:16:49,627 [salt.minion      ][INFO    ][26228] Starting a new job with PID 26228
2017-12-10 10:16:49,631 [salt.minion      ][INFO    ][26228] Returning information for job: 20171210101649601951
2017-12-10 10:22:05,794 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command state.sls with jid 20171210102205781990
2017-12-10 10:22:05,804 [salt.minion      ][INFO    ][26349] Starting a new job with PID 26349
2017-12-10 10:22:08,100 [salt.state       ][INFO    ][26349] Loading fresh modules for state activity
2017-12-10 10:22:08,130 [salt.fileclient  ][INFO    ][26349] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-10 10:22:08,155 [salt.fileclient  ][INFO    ][26349] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-10 10:22:08,467 [salt.state       ][INFO    ][26349] Running state [attr] at time 10:22:08.466815
2017-12-10 10:22:08,467 [salt.state       ][INFO    ][26349] Executing state pkg.installed for attr
2017-12-10 10:22:08,468 [salt.loaded.int.module.cmdmod][INFO    ][26349] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:22:08,748 [salt.loaded.int.module.cmdmod][INFO    ][26349] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-10 10:22:10,078 [salt.loaded.int.module.cmdmod][INFO    ][26349] 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-12-10 10:22:11,436 [salt.loaded.int.module.cmdmod][INFO    ][26349] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:22:11,466 [salt.state       ][INFO    ][26349] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-12-10 10:22:11,477 [salt.state       ][INFO    ][26349] Loading fresh modules for state activity
2017-12-10 10:22:11,493 [salt.state       ][INFO    ][26349] Completed state [attr] at time 10:22:11.493235 duration_in_ms=3026.421
2017-12-10 10:22:11,499 [salt.state       ][INFO    ][26349] Running state [glusterfs-server] at time 10:22:11.499154
2017-12-10 10:22:11,499 [salt.state       ][INFO    ][26349] Executing state pkg.installed for glusterfs-server
2017-12-10 10:22:11,731 [salt.loaded.int.module.cmdmod][INFO    ][26349] 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-12-10 10:22:15,903 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210102215890739
2017-12-10 10:22:15,914 [salt.minion      ][INFO    ][27228] Starting a new job with PID 27228
2017-12-10 10:22:15,927 [salt.minion      ][INFO    ][27228] Returning information for job: 20171210102215890739
2017-12-10 10:22:20,598 [salt.loaded.int.module.cmdmod][INFO    ][26349] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:22:20,627 [salt.state       ][INFO    ][26349] 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'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.2'
'glusterfs-client' changed from 'absent' to '3.10.8-ubuntu1~xenial1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'glusterfs-common' changed from 'absent' to '3.10.8-ubuntu1~xenial1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'portmap' changed from 'absent' to '1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'
'nfs-client' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.10.8-ubuntu1~xenial1'

2017-12-10 10:22:20,636 [salt.state       ][INFO    ][26349] Loading fresh modules for state activity
2017-12-10 10:22:20,653 [salt.state       ][INFO    ][26349] Completed state [glusterfs-server] at time 10:22:20.653233 duration_in_ms=9154.078
2017-12-10 10:22:20,659 [salt.state       ][INFO    ][26349] Running state [bc] at time 10:22:20.658663
2017-12-10 10:22:20,659 [salt.state       ][INFO    ][26349] Executing state pkg.installed for bc
2017-12-10 10:22:20,952 [salt.loaded.int.module.cmdmod][INFO    ][26349] 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-12-10 10:22:22,437 [salt.loaded.int.module.cmdmod][INFO    ][26349] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:22:22,465 [salt.state       ][INFO    ][26349] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-12-10 10:22:22,475 [salt.state       ][INFO    ][26349] Loading fresh modules for state activity
2017-12-10 10:22:22,491 [salt.state       ][INFO    ][26349] Completed state [bc] at time 10:22:22.491098 duration_in_ms=1832.433
2017-12-10 10:22:22,564 [salt.state       ][INFO    ][26349] Running state [glusterfs-server] at time 10:22:22.564184
2017-12-10 10:22:22,565 [salt.state       ][INFO    ][26349] Executing state service.running for glusterfs-server
2017-12-10 10:22:22,566 [salt.loaded.int.module.cmdmod][INFO    ][26349] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-10 10:22:22,576 [salt.loaded.int.module.cmdmod][INFO    ][26349] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-10 10:22:22,585 [salt.loaded.int.module.cmdmod][INFO    ][26349] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-10 10:22:22,592 [salt.state       ][INFO    ][26349] The service glusterfs-server is already running
2017-12-10 10:22:22,593 [salt.state       ][INFO    ][26349] Completed state [glusterfs-server] at time 10:22:22.592697 duration_in_ms=28.5
2017-12-10 10:22:22,594 [salt.state       ][INFO    ][26349] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:22:22.594066
2017-12-10 10:22:22,594 [salt.state       ][INFO    ][26349] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-10 10:22:22,599 [salt.state       ][INFO    ][26349] File changed:
New file
2017-12-10 10:22:22,599 [salt.state       ][INFO    ][26349] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:22:22.599180 duration_in_ms=5.114
2017-12-10 10:22:22,599 [salt.state       ][INFO    ][26349] Running state [/srv/glusterfs/glance] at time 10:22:22.599375
2017-12-10 10:22:22,600 [salt.state       ][INFO    ][26349] Executing state file.directory for /srv/glusterfs/glance
2017-12-10 10:22:22,601 [salt.state       ][INFO    ][26349] {'/srv/glusterfs/glance': 'New Dir'}
2017-12-10 10:22:22,601 [salt.state       ][INFO    ][26349] Completed state [/srv/glusterfs/glance] at time 10:22:22.600799 duration_in_ms=1.423
2017-12-10 10:22:22,601 [salt.state       ][INFO    ][26349] Running state [/srv/glusterfs/keystone-keys] at time 10:22:22.601015
2017-12-10 10:22:22,601 [salt.state       ][INFO    ][26349] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-10 10:22:22,602 [salt.state       ][INFO    ][26349] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-12-10 10:22:22,602 [salt.state       ][INFO    ][26349] Completed state [/srv/glusterfs/keystone-keys] at time 10:22:22.601828 duration_in_ms=0.813
2017-12-10 10:22:22,602 [salt.state       ][INFO    ][26349] Running state [/srv/glusterfs/nova_instances] at time 10:22:22.602004
2017-12-10 10:22:22,602 [salt.state       ][INFO    ][26349] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-10 10:22:22,603 [salt.state       ][INFO    ][26349] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-12-10 10:22:22,603 [salt.state       ][INFO    ][26349] Completed state [/srv/glusterfs/nova_instances] at time 10:22:22.602807 duration_in_ms=0.803
2017-12-10 10:22:22,603 [salt.state       ][INFO    ][26349] Running state [/srv/glusterfs/keystone-credential-keys] at time 10:22:22.602993
2017-12-10 10:22:22,603 [salt.state       ][INFO    ][26349] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-10 10:22:22,604 [salt.state       ][INFO    ][26349] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-12-10 10:22:22,604 [salt.state       ][INFO    ][26349] Completed state [/srv/glusterfs/keystone-credential-keys] at time 10:22:22.603809 duration_in_ms=0.815
2017-12-10 10:22:22,605 [salt.minion      ][INFO    ][26349] Returning information for job: 20171210102205781990
2017-12-10 10:22:28,625 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command test.ping with jid 20171210102228616612
2017-12-10 10:22:28,635 [salt.minion      ][INFO    ][29197] Starting a new job with PID 29197
2017-12-10 10:22:28,670 [salt.minion      ][INFO    ][29197] Returning information for job: 20171210102228616612
2017-12-10 10:22:52,408 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command state.sls with jid 20171210102252398198
2017-12-10 10:22:52,420 [salt.minion      ][INFO    ][29831] Starting a new job with PID 29831
2017-12-10 10:22:54,757 [salt.state       ][INFO    ][29831] Loading fresh modules for state activity
2017-12-10 10:22:54,792 [salt.fileclient  ][INFO    ][29831] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-10 10:22:54,836 [salt.fileclient  ][INFO    ][29831] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-10 10:22:54,924 [salt.fileclient  ][INFO    ][29831] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-10 10:22:54,951 [salt.fileclient  ][INFO    ][29831] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-10 10:22:55,264 [salt.state       ][INFO    ][29831] Running state [attr] at time 10:22:55.263821
2017-12-10 10:22:55,264 [salt.state       ][INFO    ][29831] Executing state pkg.installed for attr
2017-12-10 10:22:55,265 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:22:55,542 [salt.state       ][INFO    ][29831] Package attr is already installed
2017-12-10 10:22:55,543 [salt.state       ][INFO    ][29831] Completed state [attr] at time 10:22:55.542458 duration_in_ms=278.638
2017-12-10 10:22:55,543 [salt.state       ][INFO    ][29831] Running state [glusterfs-server] at time 10:22:55.542698
2017-12-10 10:22:55,543 [salt.state       ][INFO    ][29831] Executing state pkg.installed for glusterfs-server
2017-12-10 10:22:55,547 [salt.state       ][INFO    ][29831] Package glusterfs-server is already installed
2017-12-10 10:22:55,547 [salt.state       ][INFO    ][29831] Completed state [glusterfs-server] at time 10:22:55.546720 duration_in_ms=4.022
2017-12-10 10:22:55,547 [salt.state       ][INFO    ][29831] Running state [bc] at time 10:22:55.546916
2017-12-10 10:22:55,547 [salt.state       ][INFO    ][29831] Executing state pkg.installed for bc
2017-12-10 10:22:55,551 [salt.state       ][INFO    ][29831] Package bc is already installed
2017-12-10 10:22:55,551 [salt.state       ][INFO    ][29831] Completed state [bc] at time 10:22:55.550781 duration_in_ms=3.864
2017-12-10 10:22:55,552 [salt.state       ][INFO    ][29831] Running state [glusterfs-server] at time 10:22:55.551824
2017-12-10 10:22:55,552 [salt.state       ][INFO    ][29831] Executing state service.running for glusterfs-server
2017-12-10 10:22:55,553 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-10 10:22:55,562 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-10 10:22:55,612 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-10 10:22:55,626 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-10 10:22:55,633 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-10 10:22:55,640 [salt.state       ][INFO    ][29831] The service glusterfs-server is already running
2017-12-10 10:22:55,641 [salt.state       ][INFO    ][29831] Completed state [glusterfs-server] at time 10:22:55.640481 duration_in_ms=88.657
2017-12-10 10:22:55,642 [salt.state       ][INFO    ][29831] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:22:55.642020
2017-12-10 10:22:55,642 [salt.state       ][INFO    ][29831] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-10 10:22:55,644 [salt.state       ][INFO    ][29831] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-10 10:22:55,644 [salt.state       ][INFO    ][29831] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:22:55.644306 duration_in_ms=2.286
2017-12-10 10:22:55,645 [salt.state       ][INFO    ][29831] Running state [/srv/glusterfs/glance] at time 10:22:55.644527
2017-12-10 10:22:55,645 [salt.state       ][INFO    ][29831] Executing state file.directory for /srv/glusterfs/glance
2017-12-10 10:22:55,645 [salt.state       ][INFO    ][29831] Directory /srv/glusterfs/glance is in the correct state
2017-12-10 10:22:55,645 [salt.state       ][INFO    ][29831] Completed state [/srv/glusterfs/glance] at time 10:22:55.645379 duration_in_ms=0.852
2017-12-10 10:22:55,646 [salt.state       ][INFO    ][29831] Running state [/srv/glusterfs/keystone-keys] at time 10:22:55.645569
2017-12-10 10:22:55,646 [salt.state       ][INFO    ][29831] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-10 10:22:55,646 [salt.state       ][INFO    ][29831] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-10 10:22:55,646 [salt.state       ][INFO    ][29831] Completed state [/srv/glusterfs/keystone-keys] at time 10:22:55.646295 duration_in_ms=0.726
2017-12-10 10:22:55,647 [salt.state       ][INFO    ][29831] Running state [/srv/glusterfs/nova_instances] at time 10:22:55.646498
2017-12-10 10:22:55,647 [salt.state       ][INFO    ][29831] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-10 10:22:55,647 [salt.state       ][INFO    ][29831] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-10 10:22:55,647 [salt.state       ][INFO    ][29831] Completed state [/srv/glusterfs/nova_instances] at time 10:22:55.647208 duration_in_ms=0.71
2017-12-10 10:22:55,647 [salt.state       ][INFO    ][29831] Running state [/srv/glusterfs/keystone-credential-keys] at time 10:22:55.647389
2017-12-10 10:22:55,648 [salt.state       ][INFO    ][29831] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-10 10:22:55,648 [salt.state       ][INFO    ][29831] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-10 10:22:55,648 [salt.state       ][INFO    ][29831] Completed state [/srv/glusterfs/keystone-credential-keys] at time 10:22:55.648100 duration_in_ms=0.711
2017-12-10 10:22:55,746 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command ['git', '--version'] in directory '/root'
2017-12-10 10:22:55,801 [salt.state       ][INFO    ][29831] Running state [sleep 5] at time 10:22:55.800650
2017-12-10 10:22:55,801 [salt.state       ][INFO    ][29831] Executing state cmd.wait for sleep 5
2017-12-10 10:22:55,801 [salt.state       ][INFO    ][29831] No changes made for sleep 5
2017-12-10 10:22:55,801 [salt.state       ][INFO    ][29831] Completed state [sleep 5] at time 10:22:55.801297 duration_in_ms=0.647
2017-12-10 10:22:55,802 [salt.state       ][INFO    ][29831] Running state [192.168.10.143] at time 10:22:55.801885
2017-12-10 10:22:55,802 [salt.state       ][INFO    ][29831] Executing state glusterfs.peered for 192.168.10.143
2017-12-10 10:22:55,802 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:55,811 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:55,867 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:55,877 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:55,935 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:55,944 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:56,001 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:56,009 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:56,065 [salt.state       ][INFO    ][29831] Peering with localhost is not needed
2017-12-10 10:22:56,065 [salt.state       ][INFO    ][29831] Completed state [192.168.10.143] at time 10:22:56.064792 duration_in_ms=262.906
2017-12-10 10:22:56,068 [salt.state       ][INFO    ][29831] Running state [192.168.10.142] at time 10:22:56.067947
2017-12-10 10:22:56,068 [salt.state       ][INFO    ][29831] Executing state glusterfs.peered for 192.168.10.142
2017-12-10 10:22:56,069 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:56,078 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:56,136 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:56,145 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:56,204 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:56,211 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:56,267 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:56,276 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:56,331 [salt.state       ][INFO    ][29831] {'new': {'192.168.10.141': [], 'kvm02.baremetal-mcp-ocata-odl-ha.local': ['192.168.10.142']}, 'old': {'192.168.10.141': [], 'kvm02.baremetal-mcp-ocata-odl-ha.local': []}}
2017-12-10 10:22:56,331 [salt.state       ][INFO    ][29831] Completed state [192.168.10.142] at time 10:22:56.330990 duration_in_ms=263.043
2017-12-10 10:22:56,334 [salt.state       ][INFO    ][29831] Running state [192.168.10.141] at time 10:22:56.334107
2017-12-10 10:22:56,334 [salt.state       ][INFO    ][29831] Executing state glusterfs.peered for 192.168.10.141
2017-12-10 10:22:56,335 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:56,343 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:56,400 [salt.state       ][INFO    ][29831] Host 192.168.10.141 already peered
2017-12-10 10:22:56,400 [salt.state       ][INFO    ][29831] Completed state [192.168.10.141] at time 10:22:56.400274 duration_in_ms=66.166
2017-12-10 10:22:56,402 [salt.state       ][INFO    ][29831] Running state [glance] at time 10:22:56.401529
2017-12-10 10:22:56,402 [salt.state       ][INFO    ][29831] Executing state glusterfs.created for glance
2017-12-10 10:22:56,402 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:56,411 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:56,470 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:56,479 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:56,542 [salt.state       ][INFO    ][29831] Volume glance already exists and is started.
2017-12-10 10:22:56,542 [salt.state       ][INFO    ][29831] Completed state [glance] at time 10:22:56.542302 duration_in_ms=140.773
2017-12-10 10:22:56,547 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 10:22:56.546602
2017-12-10 10:22:56,547 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-10 10:22:56,547 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-10 10:22:56,604 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:56,604 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 10:22:56.603866 duration_in_ms=57.264
2017-12-10 10:22:56,605 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 10:22:56.604524
2017-12-10 10:22:56,605 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-10 10:22:56,605 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-10 10:22:56,660 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:56,661 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 10:22:56.660539 duration_in_ms=56.014
2017-12-10 10:22:56,661 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 10:22:56.661217
2017-12-10 10:22:56,662 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-10 10:22:56,662 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-10 10:22:56,718 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:56,718 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 10:22:56.717869 duration_in_ms=56.652
2017-12-10 10:22:56,719 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 10:22:56.718481
2017-12-10 10:22:56,719 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-10 10:22:56,719 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-10 10:22:56,780 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:56,780 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 10:22:56.780283 duration_in_ms=61.802
2017-12-10 10:22:56,785 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 10:22:56.784324
2017-12-10 10:22:56,786 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-10 10:22:56,787 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-10 10:22:56,846 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:56,846 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 10:22:56.846260 duration_in_ms=61.936
2017-12-10 10:22:56,847 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 10:22:56.847055
2017-12-10 10:22:56,847 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-10 10:22:56,848 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-10 10:22:56,908 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:56,909 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 10:22:56.908497 duration_in_ms=61.442
2017-12-10 10:22:56,910 [salt.state       ][INFO    ][29831] Running state [glance] at time 10:22:56.910125
2017-12-10 10:22:56,910 [salt.state       ][INFO    ][29831] Executing state glusterfs.started for glance
2017-12-10 10:22:56,911 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:56,919 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:56,977 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:56,985 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:57,045 [salt.state       ][INFO    ][29831] Volume glance is already started
2017-12-10 10:22:57,046 [salt.state       ][INFO    ][29831] Completed state [glance] at time 10:22:57.045640 duration_in_ms=135.515
2017-12-10 10:22:57,047 [salt.state       ][INFO    ][29831] Running state [keystone-keys] at time 10:22:57.047000
2017-12-10 10:22:57,047 [salt.state       ][INFO    ][29831] Executing state glusterfs.created for keystone-keys
2017-12-10 10:22:57,048 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:57,056 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:57,110 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:57,118 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:57,180 [salt.state       ][INFO    ][29831] Volume keystone-keys already exists and is started.
2017-12-10 10:22:57,180 [salt.state       ][INFO    ][29831] Completed state [keystone-keys] at time 10:22:57.179858 duration_in_ms=132.857
2017-12-10 10:22:57,185 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 10:22:57.185440
2017-12-10 10:22:57,186 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-10 10:22:57,186 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-10 10:22:57,243 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:57,243 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 10:22:57.242984 duration_in_ms=57.544
2017-12-10 10:22:57,244 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:22:57.243613
2017-12-10 10:22:57,244 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-10 10:22:57,245 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-10 10:22:57,298 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:57,298 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:22:57.298360 duration_in_ms=54.747
2017-12-10 10:22:57,299 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 10:22:57.299077
2017-12-10 10:22:57,299 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-10 10:22:57,300 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-10 10:22:57,360 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:57,360 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 10:22:57.360233 duration_in_ms=61.156
2017-12-10 10:22:57,361 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:22:57.360988
2017-12-10 10:22:57,361 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-10 10:22:57,362 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-10 10:22:57,419 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:57,419 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:22:57.418732 duration_in_ms=57.744
2017-12-10 10:22:57,419 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 10:22:57.419364
2017-12-10 10:22:57,420 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-10 10:22:57,420 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-10 10:22:57,479 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:57,479 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 10:22:57.479256 duration_in_ms=59.892
2017-12-10 10:22:57,480 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 10:22:57.479824
2017-12-10 10:22:57,480 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-10 10:22:57,481 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-10 10:22:57,539 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:57,540 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 10:22:57.539659 duration_in_ms=59.824
2017-12-10 10:22:57,541 [salt.state       ][INFO    ][29831] Running state [keystone-keys] at time 10:22:57.541378
2017-12-10 10:22:57,542 [salt.state       ][INFO    ][29831] Executing state glusterfs.started for keystone-keys
2017-12-10 10:22:57,542 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:57,552 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:57,606 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:57,614 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:57,678 [salt.state       ][INFO    ][29831] Volume keystone-keys is already started
2017-12-10 10:22:57,678 [salt.state       ][INFO    ][29831] Completed state [keystone-keys] at time 10:22:57.677887 duration_in_ms=136.508
2017-12-10 10:22:57,679 [salt.state       ][INFO    ][29831] Running state [nova_instances] at time 10:22:57.678910
2017-12-10 10:22:57,679 [salt.state       ][INFO    ][29831] Executing state glusterfs.created for nova_instances
2017-12-10 10:22:57,680 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:57,689 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:57,746 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:57,755 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:57,817 [salt.state       ][INFO    ][29831] Volume nova_instances already exists and is started.
2017-12-10 10:22:57,817 [salt.state       ][INFO    ][29831] Completed state [nova_instances] at time 10:22:57.816915 duration_in_ms=138.005
2017-12-10 10:22:57,821 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 10:22:57.821362
2017-12-10 10:22:57,822 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-10 10:22:57,822 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-10 10:22:57,878 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:57,878 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 10:22:57.878201 duration_in_ms=56.839
2017-12-10 10:22:57,879 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 10:22:57.878937
2017-12-10 10:22:57,879 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-10 10:22:57,880 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-10 10:22:57,940 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:57,941 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 10:22:57.940664 duration_in_ms=61.727
2017-12-10 10:22:57,941 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 10:22:57.941420
2017-12-10 10:22:57,942 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-10 10:22:57,942 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-10 10:22:57,999 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:57,999 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 10:22:57.999101 duration_in_ms=57.681
2017-12-10 10:22:57,1000 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 10:22:57.999817
2017-12-10 10:22:58,000 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-10 10:22:58,001 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-10 10:22:58,057 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:58,058 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 10:22:58.057542 duration_in_ms=57.724
2017-12-10 10:22:58,058 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 10:22:58.058307
2017-12-10 10:22:58,059 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-10 10:22:58,059 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-10 10:22:58,117 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:58,117 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 10:22:58.117072 duration_in_ms=58.766
2017-12-10 10:22:58,118 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 10:22:58.117658
2017-12-10 10:22:58,118 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-10 10:22:58,118 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-10 10:22:58,176 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:58,176 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 10:22:58.176253 duration_in_ms=58.593
2017-12-10 10:22:58,178 [salt.state       ][INFO    ][29831] Running state [nova_instances] at time 10:22:58.177852
2017-12-10 10:22:58,178 [salt.state       ][INFO    ][29831] Executing state glusterfs.started for nova_instances
2017-12-10 10:22:58,179 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:58,187 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:58,246 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:58,254 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:58,322 [salt.state       ][INFO    ][29831] Volume nova_instances is already started
2017-12-10 10:22:58,323 [salt.state       ][INFO    ][29831] Completed state [nova_instances] at time 10:22:58.322725 duration_in_ms=144.872
2017-12-10 10:22:58,324 [salt.state       ][INFO    ][29831] Running state [keystone-credential-keys] at time 10:22:58.323843
2017-12-10 10:22:58,324 [salt.state       ][INFO    ][29831] Executing state glusterfs.created for keystone-credential-keys
2017-12-10 10:22:58,325 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:58,334 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:58,390 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:58,399 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:58,461 [salt.state       ][INFO    ][29831] Volume keystone-credential-keys already exists and is started.
2017-12-10 10:22:58,461 [salt.state       ][INFO    ][29831] Completed state [keystone-credential-keys] at time 10:22:58.460787 duration_in_ms=136.944
2017-12-10 10:22:58,466 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 10:22:58.465550
2017-12-10 10:22:58,466 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-10 10:22:58,466 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-10 10:22:58,526 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:58,526 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 10:22:58.526186 duration_in_ms=60.635
2017-12-10 10:22:58,527 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 10:22:58.526789
2017-12-10 10:22:58,527 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-10 10:22:58,528 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-10 10:22:58,587 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:58,587 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 10:22:58.587111 duration_in_ms=60.32
2017-12-10 10:22:58,588 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:22:58.587835
2017-12-10 10:22:58,588 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-10 10:22:58,589 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-10 10:22:58,646 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:58,646 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:22:58.645840 duration_in_ms=58.004
2017-12-10 10:22:58,647 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 10:22:58.646535
2017-12-10 10:22:58,647 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-10 10:22:58,647 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-10 10:22:58,702 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:58,703 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 10:22:58.702577 duration_in_ms=56.041
2017-12-10 10:22:58,703 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:22:58.703380
2017-12-10 10:22:58,704 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-10 10:22:58,704 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-10 10:22:58,760 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:58,761 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:22:58.760724 duration_in_ms=57.344
2017-12-10 10:22:58,761 [salt.state       ][INFO    ][29831] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 10:22:58.761459
2017-12-10 10:22:58,762 [salt.state       ][INFO    ][29831] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-10 10:22:58,762 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-10 10:22:58,822 [salt.state       ][INFO    ][29831] unless execution succeeded
2017-12-10 10:22:58,822 [salt.state       ][INFO    ][29831] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 10:22:58.822372 duration_in_ms=60.911
2017-12-10 10:22:58,824 [salt.state       ][INFO    ][29831] Running state [keystone-credential-keys] at time 10:22:58.823829
2017-12-10 10:22:58,824 [salt.state       ][INFO    ][29831] Executing state glusterfs.started for keystone-credential-keys
2017-12-10 10:22:58,825 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:58,834 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:58,893 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --version' in directory '/root'
2017-12-10 10:22:58,900 [salt.loaded.int.module.cmdmod][INFO    ][29831] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-10 10:22:58,960 [salt.state       ][INFO    ][29831] Volume keystone-credential-keys is already started
2017-12-10 10:22:58,960 [salt.state       ][INFO    ][29831] Completed state [keystone-credential-keys] at time 10:22:58.960111 duration_in_ms=136.281
2017-12-10 10:22:58,963 [salt.minion      ][INFO    ][29831] Returning information for job: 20171210102252398198
2017-12-10 10:23:04,627 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command test.ping with jid 20171210102304618043
2017-12-10 10:23:04,639 [salt.minion      ][INFO    ][30392] Starting a new job with PID 30392
2017-12-10 10:23:04,675 [salt.minion      ][INFO    ][30392] Returning information for job: 20171210102304618043
2017-12-10 10:23:05,184 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command cmd.run with jid 20171210102305172665
2017-12-10 10:23:05,196 [salt.minion      ][INFO    ][30397] Starting a new job with PID 30397
2017-12-10 10:23:05,200 [salt.loaded.int.module.cmdmod][INFO    ][30397] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-10 10:23:05,326 [salt.minion      ][INFO    ][30397] Returning information for job: 20171210102305172665
2017-12-10 10:46:43,186 [salt.utils.schedule][INFO    ][16102] Running scheduled job: __mine_interval
2017-12-10 11:22:14,166 [salt.minion      ][INFO    ][16102] User sudo_ubuntu Executing command cp.push_dir with jid 20171210112214153814
2017-12-10 11:22:14,183 [salt.minion      ][INFO    ][31262] Starting a new job with PID 31262
