2017-11-30 05:49:38,700 [salt.cli.daemons ][WARNING ][1993] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-30 05:50:33,829 [salt.state       ][ERROR   ][3661] No contents found in top file
2017-11-30 05:53:08,355 [salt.utils.parsers][WARNING ][1993] Minion received a SIGTERM. Exiting.
2017-11-30 05:57:36,417 [salt.cli.daemons ][WARNING ][3292] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-30 05:59:45,155 [py.warnings      ][WARNING ][14483] /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-11-30 06:00:06,255 [salt.transport.ipc][ERROR   ][3292] Exception occurred while handling stream: [Errno 0] Success
2017-11-30 06:01:49,657 [salt.loaded.int.module.cmdmod][ERROR   ][14483] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-30 06:01:49,663 [salt.loaded.int.module.cmdmod][ERROR   ][14483] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-30 06:01:54,754 [salt.loaded.int.module.cmdmod][ERROR   ][14483] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-30 06:01:54,755 [salt.loaded.int.module.cmdmod][ERROR   ][14483] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-30 06:01:59,694 [salt.loaded.int.module.cmdmod][ERROR   ][14483] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-30 06:01:59,695 [salt.loaded.int.module.cmdmod][ERROR   ][14483] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-30 06:02:04,789 [salt.loaded.int.module.cmdmod][ERROR   ][14483] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-30 06:02:04,791 [salt.loaded.int.module.cmdmod][ERROR   ][14483] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-30 06:02:09,261 [salt.loaded.int.module.cmdmod][ERROR   ][14483] 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-11-30 06:02:12,889 [salt.state       ][ERROR   ][21679] No contents found in top file
2017-11-30 06:02:16,525 [salt.loaded.int.module.cmdmod][INFO    ][21852] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-30 06:02:16,540 [salt.loaded.int.module.cmdmod][INFO    ][21852] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-30 06:02:16,562 [salt.loaded.int.module.cmdmod][INFO    ][21852] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-30 06:02:16,581 [salt.utils.parsers][WARNING ][3292] Minion received a SIGTERM. Exiting.
2017-11-30 06:02:16,998 [salt.cli.daemons ][INFO    ][21969] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-11-30 06:02:17,856 [salt.minion      ][INFO    ][21969] Creating minion process manager
2017-11-30 06:02:17,857 [salt.cli.daemons ][WARNING ][21969] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-30 06:02:17,857 [salt.cli.daemons ][INFO    ][21969] The Salt Minion is starting up
2017-11-30 06:02:17,857 [salt.minion      ][INFO    ][21969] Minion is starting as user 'root'
2017-11-30 06:02:17,858 [salt.utils.event ][INFO    ][21969] Starting pull socket on /var/run/salt/minion/minion_event_0031115955_pull.ipc
2017-11-30 06:02:19,178 [salt.loaded.int.module.cmdmod][INFO    ][21969] Executing command ['date', '+%z'] in directory '/root'
2017-11-30 06:02:19,191 [salt.utils.schedule][INFO    ][21969] Updating job settings for scheduled job: __mine_interval
2017-11-30 06:02:19,196 [salt.minion      ][INFO    ][21969] Added mine.update to scheduler
2017-11-30 06:02:19,217 [salt.minion      ][INFO    ][21969] Minion is ready to receive requests!
2017-11-30 06:02:20,219 [salt.utils.schedule][INFO    ][21969] Running scheduled job: __mine_interval
2017-11-30 06:02:25,544 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command saltutil.find_job with jid 20171130060225538173
2017-11-30 06:02:25,564 [salt.minion      ][INFO    ][22068] Starting a new job with PID 22068
2017-11-30 06:02:25,581 [salt.minion      ][INFO    ][22068] Returning information for job: 20171130060225538173
2017-11-30 06:02:46,479 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command state.sls with jid 20171130060246472837
2017-11-30 06:02:46,497 [salt.minion      ][INFO    ][22073] Starting a new job with PID 22073
2017-11-30 06:02:49,137 [salt.state       ][INFO    ][22073] Loading fresh modules for state activity
2017-11-30 06:02:49,174 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-30 06:02:49,198 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-30 06:02:49,233 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-30 06:02:49,336 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-30 06:02:49,353 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-30 06:02:49,389 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-30 06:02:49,473 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-30 06:02:49,498 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-30 06:02:49,611 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-30 06:02:49,636 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-30 06:02:49,928 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-30 06:02:49,945 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-30 06:02:49,958 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-30 06:02:49,994 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-30 06:02:50,027 [py.warnings      ][WARNING ][22073] /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-11-30 06:02:50,027 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'salt-minion --version' in directory '/root'
2017-11-30 06:02:50,375 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-30 06:02:50,403 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-30 06:02:50,417 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-30 06:02:50,434 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-30 06:02:50,486 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-30 06:02:50,501 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-30 06:02:50,526 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-11-30 06:02:50,543 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-11-30 06:02:50,565 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-30 06:02:50,610 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-30 06:02:50,684 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-30 06:02:50,713 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-30 06:02:50,789 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-30 06:02:50,815 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-30 06:02:50,881 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-30 06:02:50,906 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-30 06:02:50,922 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-30 06:02:50,944 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-30 06:02:50,960 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-30 06:02:50,998 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-30 06:02:51,024 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'salt-minion --version' in directory '/root'
2017-11-30 06:02:51,356 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-30 06:02:51,377 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-30 06:02:51,389 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-30 06:02:51,402 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-30 06:02:51,449 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-30 06:02:51,463 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-30 06:02:51,488 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-11-30 06:02:51,504 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-11-30 06:02:51,529 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-30 06:02:51,570 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-30 06:02:51,656 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-30 06:02:51,734 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-30 06:02:52,156 [salt.state       ][INFO    ][22073] Running state [salt-minion] at time 06:02:52.155654
2017-11-30 06:02:52,156 [salt.state       ][INFO    ][22073] Executing state pkg.installed for salt-minion
2017-11-30 06:02:52,156 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-30 06:02:52,448 [salt.state       ][INFO    ][22073] Package salt-minion is already installed
2017-11-30 06:02:52,448 [salt.state       ][INFO    ][22073] Completed state [salt-minion] at time 06:02:52.448194 duration_in_ms=292.54
2017-11-30 06:02:52,449 [salt.state       ][INFO    ][22073] Running state [salt_minion_dependency_packages] at time 06:02:52.448789
2017-11-30 06:02:52,449 [salt.state       ][INFO    ][22073] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-30 06:02:52,453 [salt.state       ][INFO    ][22073] All specified packages are already installed
2017-11-30 06:02:52,453 [salt.state       ][INFO    ][22073] Completed state [salt_minion_dependency_packages] at time 06:02:52.453142 duration_in_ms=4.353
2017-11-30 06:02:52,455 [salt.state       ][INFO    ][22073] Running state [/etc/salt/minion.d/minion.conf] at time 06:02:52.454740
2017-11-30 06:02:52,455 [salt.state       ][INFO    ][22073] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-30 06:02:52,473 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-30 06:02:52,535 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-30 06:02:52,597 [salt.fileclient  ][INFO    ][22073] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-30 06:02:52,653 [salt.state       ][INFO    ][22073] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-30 06:02:52,653 [salt.state       ][INFO    ][22073] Completed state [/etc/salt/minion.d/minion.conf] at time 06:02:52.653228 duration_in_ms=198.487
2017-11-30 06:02:52,654 [salt.state       ][INFO    ][22073] Running state [/etc/salt/minion.d/_virt.conf] at time 06:02:52.653968
2017-11-30 06:02:52,654 [salt.state       ][INFO    ][22073] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-30 06:02:52,655 [salt.state       ][INFO    ][22073] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-30 06:02:52,655 [salt.state       ][INFO    ][22073] Completed state [/etc/salt/minion.d/_virt.conf] at time 06:02:52.654996 duration_in_ms=1.028
2017-11-30 06:02:52,657 [salt.state       ][INFO    ][22073] Running state [salt-minion] at time 06:02:52.656580
2017-11-30 06:02:52,657 [salt.state       ][INFO    ][22073] Executing state service.running for salt-minion
2017-11-30 06:02:52,657 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-30 06:02:52,691 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-30 06:02:52,709 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-30 06:02:52,727 [salt.state       ][INFO    ][22073] The service salt-minion is already running
2017-11-30 06:02:52,727 [salt.state       ][INFO    ][22073] Completed state [salt-minion] at time 06:02:52.727191 duration_in_ms=70.609
2017-11-30 06:02:52,731 [salt.state       ][INFO    ][22073] Running state [/etc/salt/grains.d] at time 06:02:52.730949
2017-11-30 06:02:52,732 [salt.state       ][INFO    ][22073] Executing state file.directory for /etc/salt/grains.d
2017-11-30 06:02:52,733 [salt.state       ][INFO    ][22073] Directory /etc/salt/grains.d is in the correct state
2017-11-30 06:02:52,734 [salt.state       ][INFO    ][22073] Completed state [/etc/salt/grains.d] at time 06:02:52.733304 duration_in_ms=2.355
2017-11-30 06:02:52,735 [salt.state       ][INFO    ][22073] Running state [/etc/salt/grains] at time 06:02:52.734943
2017-11-30 06:02:52,735 [salt.state       ][INFO    ][22073] Executing state file.managed for /etc/salt/grains
2017-11-30 06:02:52,736 [salt.state       ][INFO    ][22073] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-30 06:02:52,736 [salt.state       ][INFO    ][22073] Completed state [/etc/salt/grains] at time 06:02:52.735899 duration_in_ms=0.956
2017-11-30 06:02:52,736 [salt.state       ][INFO    ][22073] Running state [/etc/salt/grains.d/placeholder] at time 06:02:52.736381
2017-11-30 06:02:52,737 [salt.state       ][INFO    ][22073] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-30 06:02:52,738 [salt.state       ][INFO    ][22073] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-30 06:02:52,738 [salt.state       ][INFO    ][22073] Completed state [/etc/salt/grains.d/placeholder] at time 06:02:52.738217 duration_in_ms=1.836
2017-11-30 06:02:52,739 [salt.state       ][INFO    ][22073] Running state [/etc/salt/grains.d/sphinx] at time 06:02:52.738692
2017-11-30 06:02:52,739 [salt.state       ][INFO    ][22073] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-30 06:02:52,741 [salt.state       ][INFO    ][22073] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.142
               - 192.168.11.252
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-30 06:02:52,741 [salt.state       ][INFO    ][22073] Completed state [/etc/salt/grains.d/sphinx] at time 06:02:52.741024 duration_in_ms=2.332
2017-11-30 06:02:52,743 [salt.state       ][INFO    ][22073] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:02:52.742569
2017-11-30 06:02:52,743 [salt.state       ][INFO    ][22073] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-30 06:02:52,743 [salt.state       ][INFO    ][22073] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-30 06:02:52,743 [salt.state       ][INFO    ][22073] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:02:52.743330 duration_in_ms=0.761
2017-11-30 06:02:52,744 [salt.state       ][INFO    ][22073] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:02:52.743546
2017-11-30 06:02:52,744 [salt.state       ][INFO    ][22073] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-30 06:02:52,745 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-30 06:02:52,839 [salt.state       ][INFO    ][22073] {'pid': 22122, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-30 06:02:52,840 [salt.state       ][INFO    ][22073] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:02:52.839788 duration_in_ms=96.241
2017-11-30 06:02:52,841 [salt.state       ][INFO    ][22073] Running state [/etc/salt/grains.d/dns_records] at time 06:02:52.841038
2017-11-30 06:02:52,842 [salt.state       ][INFO    ][22073] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-30 06:02:52,844 [salt.state       ][INFO    ][22073] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-30 06:02:52,844 [salt.state       ][INFO    ][22073] Completed state [/etc/salt/grains.d/dns_records] at time 06:02:52.843948 duration_in_ms=2.91
2017-11-30 06:02:52,846 [salt.state       ][INFO    ][22073] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 06:02:52.845944
2017-11-30 06:02:52,846 [salt.state       ][INFO    ][22073] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-30 06:02:52,847 [salt.state       ][INFO    ][22073] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-30 06:02:52,847 [salt.state       ][INFO    ][22073] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 06:02:52.846818 duration_in_ms=0.874
2017-11-30 06:02:52,847 [salt.state       ][INFO    ][22073] Running state [/etc/salt/grains.d/salt] at time 06:02:52.847346
2017-11-30 06:02:52,848 [salt.state       ][INFO    ][22073] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-30 06:02:52,849 [salt.state       ][INFO    ][22073] File /etc/salt/grains.d/salt is in the correct state
2017-11-30 06:02:52,849 [salt.state       ][INFO    ][22073] Completed state [/etc/salt/grains.d/salt] at time 06:02:52.848788 duration_in_ms=1.441
2017-11-30 06:02:52,850 [salt.state       ][INFO    ][22073] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 06:02:52.849817
2017-11-30 06:02:52,850 [salt.state       ][INFO    ][22073] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-30 06:02:52,850 [salt.state       ][INFO    ][22073] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-30 06:02:52,851 [salt.state       ][INFO    ][22073] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 06:02:52.850643 duration_in_ms=0.825
2017-11-30 06:02:52,853 [salt.state       ][INFO    ][22073] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:02:52.853291
2017-11-30 06:02:52,854 [salt.state       ][INFO    ][22073] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-30 06:02:52,855 [salt.state       ][INFO    ][22073] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-30 06:02:52,855 [salt.state       ][INFO    ][22073] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:02:52.854716 duration_in_ms=1.425
2017-11-30 06:02:52,855 [salt.state       ][INFO    ][22073] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:02:52.854949
2017-11-30 06:02:52,855 [salt.state       ][INFO    ][22073] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-30 06:02:52,858 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-30 06:02:52,871 [salt.state       ][INFO    ][22073] {'pid': 22124, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-30 06:02:52,872 [salt.state       ][INFO    ][22073] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:02:52.872086 duration_in_ms=17.136
2017-11-30 06:02:52,875 [salt.state       ][INFO    ][22073] Running state [mine.update] at time 06:02:52.874424
2017-11-30 06:02:52,875 [salt.state       ][INFO    ][22073] Executing state module.wait for mine.update
2017-11-30 06:02:52,876 [salt.state       ][INFO    ][22073] No changes made for mine.update
2017-11-30 06:02:52,876 [salt.state       ][INFO    ][22073] Completed state [mine.update] at time 06:02:52.875939 duration_in_ms=1.516
2017-11-30 06:02:52,876 [salt.state       ][INFO    ][22073] Running state [mine.update] at time 06:02:52.876343
2017-11-30 06:02:52,877 [salt.state       ][INFO    ][22073] Executing state module.mod_watch for mine.update
2017-11-30 06:02:53,414 [salt.state       ][INFO    ][22073] {'ret': True}
2017-11-30 06:02:53,416 [salt.state       ][INFO    ][22073] Completed state [mine.update] at time 06:02:53.415221 duration_in_ms=538.877
2017-11-30 06:02:53,416 [salt.state       ][INFO    ][22073] Running state [ca-certificates] at time 06:02:53.416096
2017-11-30 06:02:53,417 [salt.state       ][INFO    ][22073] Executing state pkg.installed for ca-certificates
2017-11-30 06:02:53,427 [salt.state       ][INFO    ][22073] Package ca-certificates is already installed
2017-11-30 06:02:53,427 [salt.state       ][INFO    ][22073] Completed state [ca-certificates] at time 06:02:53.427000 duration_in_ms=10.905
2017-11-30 06:02:53,428 [salt.state       ][INFO    ][22073] Running state [update-ca-certificates] at time 06:02:53.427606
2017-11-30 06:02:53,428 [salt.state       ][INFO    ][22073] Executing state cmd.wait for update-ca-certificates
2017-11-30 06:02:53,428 [salt.state       ][INFO    ][22073] No changes made for update-ca-certificates
2017-11-30 06:02:53,428 [salt.state       ][INFO    ][22073] Completed state [update-ca-certificates] at time 06:02:53.428178 duration_in_ms=0.573
2017-11-30 06:02:53,428 [salt.state       ][INFO    ][22073] Running state [libvirt-dev] at time 06:02:53.428354
2017-11-30 06:02:53,429 [salt.state       ][INFO    ][22073] Executing state pkg.installed for libvirt-dev
2017-11-30 06:02:53,432 [salt.state       ][INFO    ][22073] Package libvirt-dev is already installed
2017-11-30 06:02:53,432 [salt.state       ][INFO    ][22073] Completed state [libvirt-dev] at time 06:02:53.432277 duration_in_ms=3.923
2017-11-30 06:02:53,432 [salt.state       ][INFO    ][22073] Running state [pkg-config] at time 06:02:53.432457
2017-11-30 06:02:53,433 [salt.state       ][INFO    ][22073] Executing state pkg.installed for pkg-config
2017-11-30 06:02:53,437 [salt.state       ][INFO    ][22073] Package pkg-config is already installed
2017-11-30 06:02:53,437 [salt.state       ][INFO    ][22073] Completed state [pkg-config] at time 06:02:53.436719 duration_in_ms=4.262
2017-11-30 06:02:53,437 [salt.state       ][INFO    ][22073] Running state [virtng.init] at time 06:02:53.436901
2017-11-30 06:02:53,437 [salt.state       ][INFO    ][22073] Executing state module.run for virtng.init
2017-11-30 06:02:53,505 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command ['git', '--version'] in directory '/root'
2017-11-30 06:02:53,606 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-30 06:02:53,638 [salt.state       ][INFO    ][22073] unless execution succeeded
2017-11-30 06:02:53,639 [salt.state       ][INFO    ][22073] Completed state [virtng.init] at time 06:02:53.638600 duration_in_ms=201.698
2017-11-30 06:02:53,639 [salt.state       ][INFO    ][22073] Running state [virt.set_autostart] at time 06:02:53.639152
2017-11-30 06:02:53,640 [salt.state       ][INFO    ][22073] Executing state module.run for virt.set_autostart
2017-11-30 06:02:53,647 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-30 06:02:53,689 [salt.state       ][INFO    ][22073] unless execution succeeded
2017-11-30 06:02:53,690 [salt.state       ][INFO    ][22073] Completed state [virt.set_autostart] at time 06:02:53.690328 duration_in_ms=51.176
2017-11-30 06:02:53,691 [salt.state       ][INFO    ][22073] Running state [virtng.init] at time 06:02:53.690920
2017-11-30 06:02:53,691 [salt.state       ][INFO    ][22073] Executing state module.run for virtng.init
2017-11-30 06:02:53,700 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-30 06:02:53,735 [salt.state       ][INFO    ][22073] unless execution succeeded
2017-11-30 06:02:53,736 [salt.state       ][INFO    ][22073] Completed state [virtng.init] at time 06:02:53.735856 duration_in_ms=44.935
2017-11-30 06:02:53,736 [salt.state       ][INFO    ][22073] Running state [virt.set_autostart] at time 06:02:53.736378
2017-11-30 06:02:53,737 [salt.state       ][INFO    ][22073] Executing state module.run for virt.set_autostart
2017-11-30 06:02:53,744 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-30 06:02:53,784 [salt.state       ][INFO    ][22073] unless execution succeeded
2017-11-30 06:02:53,785 [salt.state       ][INFO    ][22073] Completed state [virt.set_autostart] at time 06:02:53.784956 duration_in_ms=48.578
2017-11-30 06:02:53,787 [salt.state       ][INFO    ][22073] Running state [virtng.init] at time 06:02:53.786750
2017-11-30 06:02:53,788 [salt.state       ][INFO    ][22073] Executing state module.run for virtng.init
2017-11-30 06:02:53,794 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-30 06:02:53,830 [salt.state       ][INFO    ][22073] unless execution succeeded
2017-11-30 06:02:53,831 [salt.state       ][INFO    ][22073] Completed state [virtng.init] at time 06:02:53.830545 duration_in_ms=43.793
2017-11-30 06:02:53,831 [salt.state       ][INFO    ][22073] Running state [virt.set_autostart] at time 06:02:53.831043
2017-11-30 06:02:53,832 [salt.state       ][INFO    ][22073] Executing state module.run for virt.set_autostart
2017-11-30 06:02:53,839 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-30 06:02:53,872 [salt.state       ][INFO    ][22073] unless execution succeeded
2017-11-30 06:02:53,873 [salt.state       ][INFO    ][22073] Completed state [virt.set_autostart] at time 06:02:53.872850 duration_in_ms=41.808
2017-11-30 06:02:53,873 [salt.state       ][INFO    ][22073] Running state [virtng.init] at time 06:02:53.873205
2017-11-30 06:02:53,875 [salt.state       ][INFO    ][22073] Executing state module.run for virtng.init
2017-11-30 06:02:53,881 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-30 06:02:53,912 [salt.state       ][INFO    ][22073] unless execution succeeded
2017-11-30 06:02:53,912 [salt.state       ][INFO    ][22073] Completed state [virtng.init] at time 06:02:53.911800 duration_in_ms=38.596
2017-11-30 06:02:53,912 [salt.state       ][INFO    ][22073] Running state [virt.set_autostart] at time 06:02:53.912053
2017-11-30 06:02:53,912 [salt.state       ][INFO    ][22073] Executing state module.run for virt.set_autostart
2017-11-30 06:02:53,918 [salt.loaded.int.module.cmdmod][INFO    ][22073] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-30 06:02:53,949 [salt.state       ][INFO    ][22073] unless execution succeeded
2017-11-30 06:02:53,949 [salt.state       ][INFO    ][22073] Completed state [virt.set_autostart] at time 06:02:53.948968 duration_in_ms=36.912
2017-11-30 06:02:53,956 [salt.minion      ][INFO    ][22073] Returning information for job: 20171130060246472837
2017-11-30 06:03:12,903 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171130060312896454
2017-11-30 06:03:12,929 [salt.minion      ][INFO    ][22172] Starting a new job with PID 22172
2017-11-30 06:03:17,278 [salt.state       ][INFO    ][22172] Loading fresh modules for state activity
2017-11-30 06:03:17,319 [salt.state       ][ERROR   ][22172] No contents found in top file
2017-11-30 06:03:17,321 [salt.utils.extmods][INFO    ][22172] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-30 06:03:17,326 [salt.utils.extmods][INFO    ][22172] Syncing beacons for environment 'base'
2017-11-30 06:03:17,326 [salt.utils.extmods][INFO    ][22172] Loading cache from salt://_beacons, for base)
2017-11-30 06:03:17,327 [salt.fileclient  ][INFO    ][22172] Caching directory '_beacons/' for environment 'base'
2017-11-30 06:03:17,390 [salt.utils.extmods][INFO    ][22172] Syncing modules for environment 'base'
2017-11-30 06:03:17,390 [salt.utils.extmods][INFO    ][22172] Loading cache from salt://_modules, for base)
2017-11-30 06:03:17,390 [salt.fileclient  ][INFO    ][22172] Caching directory '_modules/' for environment 'base'
2017-11-30 06:03:17,478 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-11-30 06:03:17,775 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-30 06:03:17,790 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-30 06:03:17,809 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-30 06:03:17,823 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-30 06:03:17,884 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-30 06:03:17,901 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-30 06:03:17,920 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-30 06:03:18,173 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-30 06:03:18,197 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-30 06:03:18,217 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-30 06:03:18,246 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-30 06:03:18,267 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-30 06:03:18,291 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-30 06:03:18,310 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-30 06:03:18,330 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-30 06:03:18,347 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-30 06:03:18,367 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-30 06:03:18,386 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-30 06:03:18,407 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-30 06:03:18,426 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-30 06:03:18,442 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-30 06:03:18,473 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-30 06:03:18,494 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-30 06:03:18,518 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-30 06:03:18,571 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-30 06:03:18,591 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-30 06:03:18,614 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-30 06:03:18,635 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-30 06:03:18,669 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-30 06:03:18,688 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-30 06:03:18,705 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-30 06:03:18,727 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-30 06:03:18,775 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-30 06:03:18,783 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-30 06:03:18,784 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-11-30 06:03:18,785 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-30 06:03:18,785 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-30 06:03:18,786 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-30 06:03:18,787 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-30 06:03:18,787 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-30 06:03:18,788 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-30 06:03:18,788 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-30 06:03:18,788 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-30 06:03:18,789 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-30 06:03:18,789 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-30 06:03:18,790 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-30 06:03:18,790 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-30 06:03:18,791 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-30 06:03:18,791 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-30 06:03:18,792 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-30 06:03:18,792 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-30 06:03:18,793 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-30 06:03:18,793 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-30 06:03:18,794 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-30 06:03:18,794 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-30 06:03:18,795 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-30 06:03:18,795 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-30 06:03:18,796 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-30 06:03:18,797 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-30 06:03:18,797 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-30 06:03:18,797 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-30 06:03:18,798 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-30 06:03:18,798 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-30 06:03:18,799 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-30 06:03:18,799 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-30 06:03:18,799 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-30 06:03:18,799 [salt.utils.extmods][INFO    ][22172] 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-11-30 06:03:18,800 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-30 06:03:18,800 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-30 06:03:18,808 [salt.utils.extmods][INFO    ][22172] Syncing states for environment 'base'
2017-11-30 06:03:18,808 [salt.utils.extmods][INFO    ][22172] Loading cache from salt://_states, for base)
2017-11-30 06:03:18,808 [salt.fileclient  ][INFO    ][22172] Caching directory '_states/' for environment 'base'
2017-11-30 06:03:18,880 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-11-30 06:03:18,898 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-30 06:03:18,920 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-30 06:03:18,933 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-30 06:03:18,952 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-30 06:03:18,976 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-30 06:03:18,999 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-30 06:03:19,023 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-30 06:03:19,040 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-30 06:03:19,057 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-11-30 06:03:19,073 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-30 06:03:19,097 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-30 06:03:19,119 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-30 06:03:19,136 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-30 06:03:19,158 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-30 06:03:19,173 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-30 06:03:19,191 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-30 06:03:19,223 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-30 06:03:19,234 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-30 06:03:19,251 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-30 06:03:19,281 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-30 06:03:19,298 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-30 06:03:19,336 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-30 06:03:19,360 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-30 06:03:19,376 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-30 06:03:19,405 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-30 06:03:19,443 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-30 06:03:19,483 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-30 06:03:19,503 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-30 06:03:19,530 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-30 06:03:19,553 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-30 06:03:19,579 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-30 06:03:19,588 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-11-30 06:03:19,589 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-30 06:03:19,590 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-30 06:03:19,591 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-30 06:03:19,591 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-30 06:03:19,591 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-30 06:03:19,592 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-30 06:03:19,592 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-30 06:03:19,593 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-30 06:03:19,593 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-11-30 06:03:19,593 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-30 06:03:19,594 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-30 06:03:19,595 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-30 06:03:19,595 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-30 06:03:19,595 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-30 06:03:19,595 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-30 06:03:19,596 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-30 06:03:19,596 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-30 06:03:19,596 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-30 06:03:19,596 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-30 06:03:19,597 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-30 06:03:19,597 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-30 06:03:19,597 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-30 06:03:19,597 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-30 06:03:19,598 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-30 06:03:19,598 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-30 06:03:19,599 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-30 06:03:19,600 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-30 06:03:19,600 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-30 06:03:19,601 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-30 06:03:19,601 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-30 06:03:19,601 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-30 06:03:19,602 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-30 06:03:19,605 [salt.utils.extmods][INFO    ][22172] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-30 06:03:19,613 [salt.utils.extmods][INFO    ][22172] Syncing sdb for environment 'base'
2017-11-30 06:03:19,614 [salt.utils.extmods][INFO    ][22172] Loading cache from salt://_sdb, for base)
2017-11-30 06:03:19,614 [salt.fileclient  ][INFO    ][22172] Caching directory '_sdb/' for environment 'base'
2017-11-30 06:03:19,705 [salt.utils.extmods][INFO    ][22172] Syncing grains for environment 'base'
2017-11-30 06:03:19,705 [salt.utils.extmods][INFO    ][22172] Loading cache from salt://_grains, for base)
2017-11-30 06:03:19,705 [salt.fileclient  ][INFO    ][22172] Caching directory '_grains/' for environment 'base'
2017-11-30 06:03:19,782 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-30 06:03:19,830 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-30 06:03:19,850 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-30 06:03:19,866 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-30 06:03:19,878 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-30 06:03:19,985 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-30 06:03:20,006 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-30 06:03:20,029 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-30 06:03:20,050 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-30 06:03:20,067 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-30 06:03:20,087 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-30 06:03:20,109 [salt.fileclient  ][INFO    ][22172] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-30 06:03:20,114 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-30 06:03:20,114 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-30 06:03:20,114 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-30 06:03:20,115 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-30 06:03:20,115 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-30 06:03:20,115 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-30 06:03:20,116 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-30 06:03:20,116 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-30 06:03:20,116 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-30 06:03:20,117 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-30 06:03:20,118 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-30 06:03:20,119 [salt.utils.extmods][INFO    ][22172] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-30 06:03:20,120 [salt.utils.extmods][INFO    ][22172] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-30 06:03:20,125 [salt.utils.extmods][INFO    ][22172] Syncing renderers for environment 'base'
2017-11-30 06:03:20,125 [salt.utils.extmods][INFO    ][22172] Loading cache from salt://_renderers, for base)
2017-11-30 06:03:20,127 [salt.fileclient  ][INFO    ][22172] Caching directory '_renderers/' for environment 'base'
2017-11-30 06:03:20,186 [salt.utils.extmods][INFO    ][22172] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-30 06:03:20,189 [salt.utils.extmods][INFO    ][22172] Syncing returners for environment 'base'
2017-11-30 06:03:20,189 [salt.utils.extmods][INFO    ][22172] Loading cache from salt://_returners, for base)
2017-11-30 06:03:20,189 [salt.fileclient  ][INFO    ][22172] Caching directory '_returners/' for environment 'base'
2017-11-30 06:03:20,264 [salt.utils.extmods][INFO    ][22172] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-30 06:03:20,268 [salt.utils.extmods][INFO    ][22172] Syncing output for environment 'base'
2017-11-30 06:03:20,268 [salt.utils.extmods][INFO    ][22172] Loading cache from salt://_output, for base)
2017-11-30 06:03:20,268 [salt.fileclient  ][INFO    ][22172] Caching directory '_output/' for environment 'base'
2017-11-30 06:03:20,328 [salt.utils.extmods][INFO    ][22172] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-30 06:03:20,332 [salt.utils.extmods][INFO    ][22172] Syncing utils for environment 'base'
2017-11-30 06:03:20,332 [salt.utils.extmods][INFO    ][22172] Loading cache from salt://_utils, for base)
2017-11-30 06:03:20,332 [salt.fileclient  ][INFO    ][22172] Caching directory '_utils/' for environment 'base'
2017-11-30 06:03:20,394 [salt.utils.extmods][INFO    ][22172] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-30 06:03:20,397 [salt.utils.extmods][INFO    ][22172] Syncing log_handlers for environment 'base'
2017-11-30 06:03:20,398 [salt.utils.extmods][INFO    ][22172] Loading cache from salt://_log_handlers, for base)
2017-11-30 06:03:20,398 [salt.fileclient  ][INFO    ][22172] Caching directory '_log_handlers/' for environment 'base'
2017-11-30 06:03:20,452 [salt.utils.extmods][INFO    ][22172] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-30 06:03:20,456 [salt.utils.extmods][INFO    ][22172] Syncing proxy for environment 'base'
2017-11-30 06:03:20,456 [salt.utils.extmods][INFO    ][22172] Loading cache from salt://_proxy, for base)
2017-11-30 06:03:20,457 [salt.fileclient  ][INFO    ][22172] Caching directory '_proxy/' for environment 'base'
2017-11-30 06:03:20,507 [salt.utils.extmods][INFO    ][22172] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-30 06:03:20,511 [salt.utils.extmods][INFO    ][22172] Syncing engines for environment 'base'
2017-11-30 06:03:20,511 [salt.utils.extmods][INFO    ][22172] Loading cache from salt://_engines, for base)
2017-11-30 06:03:20,511 [salt.fileclient  ][INFO    ][22172] Caching directory '_engines/' for environment 'base'
2017-11-30 06:03:20,581 [salt.minion      ][INFO    ][22172] Returning information for job: 20171130060312896454
2017-11-30 06:13:42,752 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command test.ping with jid 20171130061342746358
2017-11-30 06:13:42,780 [salt.minion      ][INFO    ][22428] Starting a new job with PID 22428
2017-11-30 06:13:42,835 [salt.minion      ][INFO    ][22428] Returning information for job: 20171130061342746358
2017-11-30 06:14:19,877 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command state.sls with jid 20171130061419868078
2017-11-30 06:14:19,899 [salt.minion      ][INFO    ][22439] Starting a new job with PID 22439
2017-11-30 06:14:20,550 [salt.state       ][INFO    ][22439] Loading fresh modules for state activity
2017-11-30 06:14:20,603 [salt.fileclient  ][INFO    ][22439] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-30 06:14:20,631 [salt.fileclient  ][INFO    ][22439] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-30 06:14:20,673 [salt.fileclient  ][INFO    ][22439] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-30 06:14:21,073 [salt.state       ][INFO    ][22439] Running state [lsof] at time 06:14:21.072863
2017-11-30 06:14:21,073 [salt.state       ][INFO    ][22439] Executing state pkg.installed for lsof
2017-11-30 06:14:21,074 [salt.loaded.int.module.cmdmod][INFO    ][22439] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-30 06:14:21,389 [salt.state       ][INFO    ][22439] Package lsof is already installed
2017-11-30 06:14:21,390 [salt.state       ][INFO    ][22439] Completed state [lsof] at time 06:14:21.389723 duration_in_ms=316.86
2017-11-30 06:14:21,390 [salt.state       ][INFO    ][22439] Running state [keepalived] at time 06:14:21.389981
2017-11-30 06:14:21,390 [salt.state       ][INFO    ][22439] Executing state pkg.installed for keepalived
2017-11-30 06:14:21,419 [salt.loaded.int.module.cmdmod][INFO    ][22439] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-30 06:14:23,627 [salt.loaded.int.module.cmdmod][INFO    ][22439] 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-11-30 06:14:28,384 [salt.loaded.int.module.cmdmod][INFO    ][22439] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-30 06:14:28,439 [salt.state       ][INFO    ][22439] 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-11-30 06:14:28,451 [salt.state       ][INFO    ][22439] Loading fresh modules for state activity
2017-11-30 06:14:28,468 [salt.state       ][INFO    ][22439] Completed state [keepalived] at time 06:14:28.467831 duration_in_ms=7077.848
2017-11-30 06:14:28,471 [salt.state       ][INFO    ][22439] Running state [/etc/keepalived/keepalived.conf] at time 06:14:28.470511
2017-11-30 06:14:28,471 [salt.state       ][INFO    ][22439] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-30 06:14:28,507 [salt.fileclient  ][INFO    ][22439] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-30 06:14:28,556 [salt.fileclient  ][INFO    ][22439] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-30 06:14:28,570 [salt.state       ][INFO    ][22439] File changed:
New file
2017-11-30 06:14:28,571 [salt.state       ][INFO    ][22439] Completed state [/etc/keepalived/keepalived.conf] at time 06:14:28.570565 duration_in_ms=100.053
2017-11-30 06:14:28,691 [salt.state       ][INFO    ][22439] Running state [keepalived] at time 06:14:28.691257
2017-11-30 06:14:28,692 [salt.state       ][INFO    ][22439] Executing state service.running for keepalived
2017-11-30 06:14:28,693 [salt.loaded.int.module.cmdmod][INFO    ][22439] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-30 06:14:28,715 [salt.loaded.int.module.cmdmod][INFO    ][22439] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-30 06:14:28,739 [salt.loaded.int.module.cmdmod][INFO    ][22439] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-30 06:14:28,761 [salt.loaded.int.module.cmdmod][INFO    ][22439] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-30 06:14:28,780 [salt.loaded.int.module.cmdmod][INFO    ][22439] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-30 06:14:28,849 [salt.loaded.int.module.cmdmod][INFO    ][22439] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-30 06:14:28,880 [salt.loaded.int.module.cmdmod][INFO    ][22439] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-30 06:14:28,900 [salt.loaded.int.module.cmdmod][INFO    ][22439] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-30 06:14:28,924 [salt.state       ][INFO    ][22439] {'keepalived': True}
2017-11-30 06:14:28,925 [salt.state       ][INFO    ][22439] Completed state [keepalived] at time 06:14:28.924974 duration_in_ms=233.718
2017-11-30 06:14:28,929 [salt.minion      ][INFO    ][22439] Returning information for job: 20171130061419868078
2017-11-30 06:15:44,467 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command pillar.get with jid 20171130061544459123
2017-11-30 06:15:44,497 [salt.minion      ][INFO    ][23951] Starting a new job with PID 23951
2017-11-30 06:15:44,502 [salt.minion      ][INFO    ][23951] Returning information for job: 20171130061544459123
2017-11-30 06:20:55,123 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command state.sls with jid 20171130062055116620
2017-11-30 06:20:55,151 [salt.minion      ][INFO    ][24043] Starting a new job with PID 24043
2017-11-30 06:20:57,812 [salt.state       ][INFO    ][24043] Loading fresh modules for state activity
2017-11-30 06:20:57,842 [salt.fileclient  ][INFO    ][24043] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-30 06:20:57,875 [salt.fileclient  ][INFO    ][24043] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-30 06:20:58,224 [salt.state       ][INFO    ][24043] Running state [attr] at time 06:20:58.224010
2017-11-30 06:20:58,225 [salt.state       ][INFO    ][24043] Executing state pkg.installed for attr
2017-11-30 06:20:58,225 [salt.loaded.int.module.cmdmod][INFO    ][24043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-30 06:20:58,558 [salt.loaded.int.module.cmdmod][INFO    ][24043] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-30 06:21:00,816 [salt.loaded.int.module.cmdmod][INFO    ][24043] 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-11-30 06:21:02,811 [salt.loaded.int.module.cmdmod][INFO    ][24043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-30 06:21:02,867 [salt.state       ][INFO    ][24043] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-30 06:21:02,879 [salt.state       ][INFO    ][24043] Loading fresh modules for state activity
2017-11-30 06:21:02,900 [salt.state       ][INFO    ][24043] Completed state [attr] at time 06:21:02.899697 duration_in_ms=4675.688
2017-11-30 06:21:02,936 [salt.state       ][INFO    ][24043] Running state [glusterfs-server] at time 06:21:02.935992
2017-11-30 06:21:02,936 [salt.state       ][INFO    ][24043] Executing state pkg.installed for glusterfs-server
2017-11-30 06:21:03,269 [salt.loaded.int.module.cmdmod][INFO    ][24043] 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-11-30 06:21:05,234 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command saltutil.find_job with jid 20171130062105220588
2017-11-30 06:21:05,261 [salt.minion      ][INFO    ][24912] Starting a new job with PID 24912
2017-11-30 06:21:05,279 [salt.minion      ][INFO    ][24912] Returning information for job: 20171130062105220588
2017-11-30 06:21:15,304 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command saltutil.find_job with jid 20171130062115294354
2017-11-30 06:21:15,326 [salt.minion      ][INFO    ][26314] Starting a new job with PID 26314
2017-11-30 06:21:15,342 [salt.minion      ][INFO    ][26314] Returning information for job: 20171130062115294354
2017-11-30 06:21:16,755 [salt.loaded.int.module.cmdmod][INFO    ][24043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-30 06:21:16,832 [salt.state       ][INFO    ][24043] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'glusterfs-client' changed from 'absent' to '3.10.7-ubuntu1~xenial1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.2'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'glusterfs-common' changed from 'absent' to '3.10.7-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.7-ubuntu1~xenial1'

2017-11-30 06:21:16,847 [salt.state       ][INFO    ][24043] Loading fresh modules for state activity
2017-11-30 06:21:16,866 [salt.state       ][INFO    ][24043] Completed state [glusterfs-server] at time 06:21:16.866096 duration_in_ms=13930.103
2017-11-30 06:21:16,872 [salt.state       ][INFO    ][24043] Running state [bc] at time 06:21:16.872221
2017-11-30 06:21:16,872 [salt.state       ][INFO    ][24043] Executing state pkg.installed for bc
2017-11-30 06:21:17,211 [salt.loaded.int.module.cmdmod][INFO    ][24043] 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-11-30 06:21:19,241 [salt.loaded.int.module.cmdmod][INFO    ][24043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-30 06:21:19,301 [salt.state       ][INFO    ][24043] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-30 06:21:19,313 [salt.state       ][INFO    ][24043] Loading fresh modules for state activity
2017-11-30 06:21:19,347 [salt.state       ][INFO    ][24043] Completed state [bc] at time 06:21:19.346937 duration_in_ms=2474.715
2017-11-30 06:21:19,444 [salt.state       ][INFO    ][24043] Running state [glusterfs-server] at time 06:21:19.444120
2017-11-30 06:21:19,444 [salt.state       ][INFO    ][24043] Executing state service.running for glusterfs-server
2017-11-30 06:21:19,447 [salt.loaded.int.module.cmdmod][INFO    ][24043] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-30 06:21:19,460 [salt.loaded.int.module.cmdmod][INFO    ][24043] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-30 06:21:19,469 [salt.loaded.int.module.cmdmod][INFO    ][24043] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-30 06:21:19,487 [salt.state       ][INFO    ][24043] The service glusterfs-server is already running
2017-11-30 06:21:19,488 [salt.state       ][INFO    ][24043] Completed state [glusterfs-server] at time 06:21:19.487487 duration_in_ms=43.367
2017-11-30 06:21:19,492 [salt.state       ][INFO    ][24043] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:21:19.491506
2017-11-30 06:21:19,492 [salt.state       ][INFO    ][24043] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-30 06:21:19,504 [salt.state       ][INFO    ][24043] File changed:
New file
2017-11-30 06:21:19,504 [salt.state       ][INFO    ][24043] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:21:19.504340 duration_in_ms=12.834
2017-11-30 06:21:19,505 [salt.state       ][INFO    ][24043] Running state [/srv/glusterfs/glance] at time 06:21:19.504543
2017-11-30 06:21:19,505 [salt.state       ][INFO    ][24043] Executing state file.directory for /srv/glusterfs/glance
2017-11-30 06:21:19,507 [salt.state       ][INFO    ][24043] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-30 06:21:19,507 [salt.state       ][INFO    ][24043] Completed state [/srv/glusterfs/glance] at time 06:21:19.506966 duration_in_ms=2.423
2017-11-30 06:21:19,507 [salt.state       ][INFO    ][24043] Running state [/srv/glusterfs/keystone-keys] at time 06:21:19.507161
2017-11-30 06:21:19,507 [salt.state       ][INFO    ][24043] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-30 06:21:19,508 [salt.state       ][INFO    ][24043] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-30 06:21:19,508 [salt.state       ][INFO    ][24043] Completed state [/srv/glusterfs/keystone-keys] at time 06:21:19.507987 duration_in_ms=0.826
2017-11-30 06:21:19,508 [salt.state       ][INFO    ][24043] Running state [/srv/glusterfs/nova_instances] at time 06:21:19.508180
2017-11-30 06:21:19,508 [salt.state       ][INFO    ][24043] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-30 06:21:19,509 [salt.state       ][INFO    ][24043] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-30 06:21:19,509 [salt.state       ][INFO    ][24043] Completed state [/srv/glusterfs/nova_instances] at time 06:21:19.508955 duration_in_ms=0.775
2017-11-30 06:21:19,509 [salt.state       ][INFO    ][24043] Running state [/srv/glusterfs/keystone-credential-keys] at time 06:21:19.509131
2017-11-30 06:21:19,509 [salt.state       ][INFO    ][24043] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-30 06:21:19,512 [salt.state       ][INFO    ][24043] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-30 06:21:19,512 [salt.state       ][INFO    ][24043] Completed state [/srv/glusterfs/keystone-credential-keys] at time 06:21:19.511676 duration_in_ms=2.545
2017-11-30 06:21:19,513 [salt.minion      ][INFO    ][24043] Returning information for job: 20171130062055116620
2017-11-30 06:21:20,503 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command test.ping with jid 20171130062120496287
2017-11-30 06:21:20,525 [salt.minion      ][INFO    ][26869] Starting a new job with PID 26869
2017-11-30 06:21:20,567 [salt.minion      ][INFO    ][26869] Returning information for job: 20171130062120496287
2017-11-30 06:21:41,856 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command state.sls with jid 20171130062141850176
2017-11-30 06:21:41,877 [salt.minion      ][INFO    ][27499] Starting a new job with PID 27499
2017-11-30 06:21:44,255 [salt.state       ][INFO    ][27499] Loading fresh modules for state activity
2017-11-30 06:21:44,300 [salt.fileclient  ][INFO    ][27499] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-30 06:21:44,358 [salt.fileclient  ][INFO    ][27499] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-30 06:21:44,461 [salt.fileclient  ][INFO    ][27499] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-30 06:21:44,498 [salt.fileclient  ][INFO    ][27499] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-30 06:21:44,868 [salt.state       ][INFO    ][27499] Running state [attr] at time 06:21:44.868098
2017-11-30 06:21:44,869 [salt.state       ][INFO    ][27499] Executing state pkg.installed for attr
2017-11-30 06:21:44,869 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-30 06:21:45,188 [salt.state       ][INFO    ][27499] Package attr is already installed
2017-11-30 06:21:45,188 [salt.state       ][INFO    ][27499] Completed state [attr] at time 06:21:45.187827 duration_in_ms=319.729
2017-11-30 06:21:45,188 [salt.state       ][INFO    ][27499] Running state [glusterfs-server] at time 06:21:45.188103
2017-11-30 06:21:45,188 [salt.state       ][INFO    ][27499] Executing state pkg.installed for glusterfs-server
2017-11-30 06:21:45,192 [salt.state       ][INFO    ][27499] Package glusterfs-server is already installed
2017-11-30 06:21:45,192 [salt.state       ][INFO    ][27499] Completed state [glusterfs-server] at time 06:21:45.192133 duration_in_ms=4.031
2017-11-30 06:21:45,192 [salt.state       ][INFO    ][27499] Running state [bc] at time 06:21:45.192332
2017-11-30 06:21:45,193 [salt.state       ][INFO    ][27499] Executing state pkg.installed for bc
2017-11-30 06:21:45,197 [salt.state       ][INFO    ][27499] Package bc is already installed
2017-11-30 06:21:45,197 [salt.state       ][INFO    ][27499] Completed state [bc] at time 06:21:45.196914 duration_in_ms=4.582
2017-11-30 06:21:45,198 [salt.state       ][INFO    ][27499] Running state [glusterfs-server] at time 06:21:45.197944
2017-11-30 06:21:45,198 [salt.state       ][INFO    ][27499] Executing state service.running for glusterfs-server
2017-11-30 06:21:45,199 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-30 06:21:45,217 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-30 06:21:45,309 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-30 06:21:45,345 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-30 06:21:45,363 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-30 06:21:45,383 [salt.state       ][INFO    ][27499] The service glusterfs-server is already running
2017-11-30 06:21:45,383 [salt.state       ][INFO    ][27499] Completed state [glusterfs-server] at time 06:21:45.383181 duration_in_ms=185.236
2017-11-30 06:21:45,386 [salt.state       ][INFO    ][27499] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:21:45.386139
2017-11-30 06:21:45,387 [salt.state       ][INFO    ][27499] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-30 06:21:45,391 [salt.state       ][INFO    ][27499] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-30 06:21:45,392 [salt.state       ][INFO    ][27499] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:21:45.391682 duration_in_ms=5.544
2017-11-30 06:21:45,392 [salt.state       ][INFO    ][27499] Running state [/srv/glusterfs/glance] at time 06:21:45.391955
2017-11-30 06:21:45,392 [salt.state       ][INFO    ][27499] Executing state file.directory for /srv/glusterfs/glance
2017-11-30 06:21:45,393 [salt.state       ][INFO    ][27499] Directory /srv/glusterfs/glance is in the correct state
2017-11-30 06:21:45,393 [salt.state       ][INFO    ][27499] Completed state [/srv/glusterfs/glance] at time 06:21:45.392987 duration_in_ms=1.032
2017-11-30 06:21:45,393 [salt.state       ][INFO    ][27499] Running state [/srv/glusterfs/keystone-keys] at time 06:21:45.393242
2017-11-30 06:21:45,394 [salt.state       ][INFO    ][27499] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-30 06:21:45,395 [salt.state       ][INFO    ][27499] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-30 06:21:45,395 [salt.state       ][INFO    ][27499] Completed state [/srv/glusterfs/keystone-keys] at time 06:21:45.395122 duration_in_ms=1.88
2017-11-30 06:21:45,395 [salt.state       ][INFO    ][27499] Running state [/srv/glusterfs/nova_instances] at time 06:21:45.395380
2017-11-30 06:21:45,396 [salt.state       ][INFO    ][27499] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-30 06:21:45,396 [salt.state       ][INFO    ][27499] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-30 06:21:45,396 [salt.state       ][INFO    ][27499] Completed state [/srv/glusterfs/nova_instances] at time 06:21:45.396372 duration_in_ms=0.992
2017-11-30 06:21:45,397 [salt.state       ][INFO    ][27499] Running state [/srv/glusterfs/keystone-credential-keys] at time 06:21:45.396626
2017-11-30 06:21:45,397 [salt.state       ][INFO    ][27499] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-30 06:21:45,398 [salt.state       ][INFO    ][27499] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-30 06:21:45,398 [salt.state       ][INFO    ][27499] Completed state [/srv/glusterfs/keystone-credential-keys] at time 06:21:45.397951 duration_in_ms=1.325
2017-11-30 06:21:45,492 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command ['git', '--version'] in directory '/root'
2017-11-30 06:21:45,643 [salt.state       ][INFO    ][27499] Running state [sleep 5] at time 06:21:45.643437
2017-11-30 06:21:45,644 [salt.state       ][INFO    ][27499] Executing state cmd.wait for sleep 5
2017-11-30 06:21:45,644 [salt.state       ][INFO    ][27499] No changes made for sleep 5
2017-11-30 06:21:45,644 [salt.state       ][INFO    ][27499] Completed state [sleep 5] at time 06:21:45.644425 duration_in_ms=0.989
2017-11-30 06:21:45,645 [salt.state       ][INFO    ][27499] Running state [192.168.10.143] at time 06:21:45.644944
2017-11-30 06:21:45,645 [salt.state       ][INFO    ][27499] Executing state glusterfs.peered for 192.168.10.143
2017-11-30 06:21:45,646 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:45,664 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:45,751 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:45,772 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:45,871 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:45,893 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:45,982 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:46,002 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:46,089 [salt.state       ][INFO    ][27499] {'new': {'192.168.10.141': [], 'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': ['192.168.10.143']}, 'old': {'192.168.10.141': [], 'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': []}}
2017-11-30 06:21:46,091 [salt.state       ][INFO    ][27499] Completed state [192.168.10.143] at time 06:21:46.089282 duration_in_ms=444.336
2017-11-30 06:21:46,099 [salt.state       ][INFO    ][27499] Running state [192.168.10.142] at time 06:21:46.098852
2017-11-30 06:21:46,099 [salt.state       ][INFO    ][27499] Executing state glusterfs.peered for 192.168.10.142
2017-11-30 06:21:46,100 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:46,116 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:46,203 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:46,223 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:46,316 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:46,338 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:46,422 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:46,437 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:46,539 [salt.state       ][INFO    ][27499] Peering with localhost is not needed
2017-11-30 06:21:46,539 [salt.state       ][INFO    ][27499] Completed state [192.168.10.142] at time 06:21:46.539016 duration_in_ms=440.161
2017-11-30 06:21:46,547 [salt.state       ][INFO    ][27499] Running state [192.168.10.141] at time 06:21:46.547058
2017-11-30 06:21:46,548 [salt.state       ][INFO    ][27499] Executing state glusterfs.peered for 192.168.10.141
2017-11-30 06:21:46,548 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:46,564 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:46,647 [salt.state       ][INFO    ][27499] Host 192.168.10.141 already peered
2017-11-30 06:21:46,647 [salt.state       ][INFO    ][27499] Completed state [192.168.10.141] at time 06:21:46.647220 duration_in_ms=100.161
2017-11-30 06:21:46,650 [salt.state       ][INFO    ][27499] Running state [glance] at time 06:21:46.649368
2017-11-30 06:21:46,650 [salt.state       ][INFO    ][27499] Executing state glusterfs.created for glance
2017-11-30 06:21:46,651 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:46,673 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:46,757 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:46,774 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:46,869 [salt.state       ][INFO    ][27499] Volume glance already exists and is started.
2017-11-30 06:21:46,869 [salt.state       ][INFO    ][27499] Completed state [glance] at time 06:21:46.869048 duration_in_ms=219.679
2017-11-30 06:21:46,880 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:46.879969
2017-11-30 06:21:46,881 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-30 06:21:46,881 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-30 06:21:46,971 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:46,972 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:46.971835 duration_in_ms=91.864
2017-11-30 06:21:46,973 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 06:21:46.973020
2017-11-30 06:21:46,974 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-30 06:21:46,975 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-30 06:21:47,069 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:47,070 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 06:21:47.070058 duration_in_ms=97.037
2017-11-30 06:21:47,071 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 06:21:47.071354
2017-11-30 06:21:47,072 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-30 06:21:47,073 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-30 06:21:47,166 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:47,167 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 06:21:47.167195 duration_in_ms=95.84
2017-11-30 06:21:47,169 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 06:21:47.168511
2017-11-30 06:21:47,169 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-11-30 06:21:47,170 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-30 06:21:47,267 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:47,267 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 06:21:47.267048 duration_in_ms=98.536
2017-11-30 06:21:47,269 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:47.268760
2017-11-30 06:21:47,269 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-30 06:21:47,271 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-30 06:21:47,364 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:47,364 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:47.364226 duration_in_ms=95.466
2017-11-30 06:21:47,366 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 06:21:47.365309
2017-11-30 06:21:47,367 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-30 06:21:47,368 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-30 06:21:47,460 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:47,460 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 06:21:47.459939 duration_in_ms=94.63
2017-11-30 06:21:47,464 [salt.state       ][INFO    ][27499] Running state [glance] at time 06:21:47.463597
2017-11-30 06:21:47,464 [salt.state       ][INFO    ][27499] Executing state glusterfs.started for glance
2017-11-30 06:21:47,465 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:47,483 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:47,572 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:47,588 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:47,725 [salt.state       ][INFO    ][27499] Volume glance is already started
2017-11-30 06:21:47,727 [salt.state       ][INFO    ][27499] Completed state [glance] at time 06:21:47.726545 duration_in_ms=262.947
2017-11-30 06:21:47,729 [salt.state       ][INFO    ][27499] Running state [keystone-keys] at time 06:21:47.728850
2017-11-30 06:21:47,729 [salt.state       ][INFO    ][27499] Executing state glusterfs.created for keystone-keys
2017-11-30 06:21:47,731 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:47,752 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:47,883 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:47,901 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:47,991 [salt.state       ][INFO    ][27499] Volume keystone-keys already exists and is started.
2017-11-30 06:21:47,992 [salt.state       ][INFO    ][27499] Completed state [keystone-keys] at time 06:21:47.991574 duration_in_ms=262.723
2017-11-30 06:21:48,004 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 06:21:48.003485
2017-11-30 06:21:48,004 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-30 06:21:48,004 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-30 06:21:48,096 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:48,096 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 06:21:48.095993 duration_in_ms=92.508
2017-11-30 06:21:48,097 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:48.096770
2017-11-30 06:21:48,097 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-30 06:21:48,098 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-30 06:21:48,187 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:48,187 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:48.187253 duration_in_ms=90.48
2017-11-30 06:21:48,189 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 06:21:48.188462
2017-11-30 06:21:48,189 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-30 06:21:48,191 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-30 06:21:48,296 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:48,297 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 06:21:48.296565 duration_in_ms=108.1
2017-11-30 06:21:48,299 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:48.298436
2017-11-30 06:21:48,299 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-30 06:21:48,300 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-30 06:21:48,400 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:48,400 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:48.400092 duration_in_ms=101.653
2017-11-30 06:21:48,402 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 06:21:48.401690
2017-11-30 06:21:48,402 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-30 06:21:48,403 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-30 06:21:48,500 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:48,501 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 06:21:48.500623 duration_in_ms=99.204
2017-11-30 06:21:48,502 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 06:21:48.501844
2017-11-30 06:21:48,503 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-30 06:21:48,504 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-30 06:21:48,593 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:48,593 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 06:21:48.592850 duration_in_ms=91.006
2017-11-30 06:21:48,596 [salt.state       ][INFO    ][27499] Running state [keystone-keys] at time 06:21:48.595916
2017-11-30 06:21:48,596 [salt.state       ][INFO    ][27499] Executing state glusterfs.started for keystone-keys
2017-11-30 06:21:48,597 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:48,621 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:48,706 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:48,727 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:48,819 [salt.state       ][INFO    ][27499] Volume keystone-keys is already started
2017-11-30 06:21:48,819 [salt.state       ][INFO    ][27499] Completed state [keystone-keys] at time 06:21:48.819357 duration_in_ms=223.44
2017-11-30 06:21:48,823 [salt.state       ][INFO    ][27499] Running state [nova_instances] at time 06:21:48.823130
2017-11-30 06:21:48,824 [salt.state       ][INFO    ][27499] Executing state glusterfs.created for nova_instances
2017-11-30 06:21:48,825 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:48,841 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:48,923 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:48,940 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:49,040 [salt.state       ][INFO    ][27499] Volume nova_instances already exists and is started.
2017-11-30 06:21:49,041 [salt.state       ][INFO    ][27499] Completed state [nova_instances] at time 06:21:49.040881 duration_in_ms=217.749
2017-11-30 06:21:49,057 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:49.056896
2017-11-30 06:21:49,059 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-30 06:21:49,060 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-30 06:21:49,148 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:49,149 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:49.148534 duration_in_ms=91.64
2017-11-30 06:21:49,150 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 06:21:49.150357
2017-11-30 06:21:49,151 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-11-30 06:21:49,152 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-30 06:21:49,244 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:49,244 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 06:21:49.244197 duration_in_ms=93.84
2017-11-30 06:21:49,246 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 06:21:49.246342
2017-11-30 06:21:49,247 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-11-30 06:21:49,248 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-30 06:21:49,346 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:49,347 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 06:21:49.346932 duration_in_ms=100.588
2017-11-30 06:21:49,348 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 06:21:49.348378
2017-11-30 06:21:49,349 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-11-30 06:21:49,351 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-30 06:21:49,460 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:49,460 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 06:21:49.460062 duration_in_ms=111.684
2017-11-30 06:21:49,461 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 06:21:49.461428
2017-11-30 06:21:49,462 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-11-30 06:21:49,463 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-11-30 06:21:49,566 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:49,567 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 06:21:49.566526 duration_in_ms=105.097
2017-11-30 06:21:49,568 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:49.567946
2017-11-30 06:21:49,568 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-30 06:21:49,570 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-30 06:21:49,711 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:49,712 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:49.711815 duration_in_ms=143.868
2017-11-30 06:21:49,716 [salt.state       ][INFO    ][27499] Running state [nova_instances] at time 06:21:49.716170
2017-11-30 06:21:49,717 [salt.state       ][INFO    ][27499] Executing state glusterfs.started for nova_instances
2017-11-30 06:21:49,718 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:49,737 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:49,819 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:49,839 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:49,928 [salt.state       ][INFO    ][27499] Volume nova_instances is already started
2017-11-30 06:21:49,929 [salt.state       ][INFO    ][27499] Completed state [nova_instances] at time 06:21:49.928794 duration_in_ms=212.623
2017-11-30 06:21:49,933 [salt.state       ][INFO    ][27499] Running state [keystone-credential-keys] at time 06:21:49.933046
2017-11-30 06:21:49,935 [salt.state       ][INFO    ][27499] Executing state glusterfs.created for keystone-credential-keys
2017-11-30 06:21:49,936 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:49,957 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:50,040 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:50,058 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:50,153 [salt.state       ][INFO    ][27499] Volume keystone-credential-keys already exists and is started.
2017-11-30 06:21:50,155 [salt.state       ][INFO    ][27499] Completed state [keystone-credential-keys] at time 06:21:50.154995 duration_in_ms=221.947
2017-11-30 06:21:50,166 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 06:21:50.165377
2017-11-30 06:21:50,167 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-30 06:21:50,167 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-30 06:21:50,260 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:50,260 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 06:21:50.260007 duration_in_ms=94.629
2017-11-30 06:21:50,261 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 06:21:50.261294
2017-11-30 06:21:50,263 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-30 06:21:50,264 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-30 06:21:50,359 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:50,360 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 06:21:50.359543 duration_in_ms=98.248
2017-11-30 06:21:50,361 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:50.360872
2017-11-30 06:21:50,361 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-30 06:21:50,363 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-30 06:21:50,466 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:50,467 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:50.466430 duration_in_ms=105.558
2017-11-30 06:21:50,468 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 06:21:50.467572
2017-11-30 06:21:50,468 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-30 06:21:50,469 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-30 06:21:50,571 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:50,571 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 06:21:50.571104 duration_in_ms=103.532
2017-11-30 06:21:50,572 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:50.572182
2017-11-30 06:21:50,573 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-30 06:21:50,574 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-30 06:21:50,666 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:50,667 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:50.666495 duration_in_ms=94.312
2017-11-30 06:21:50,668 [salt.state       ][INFO    ][27499] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 06:21:50.667590
2017-11-30 06:21:50,668 [salt.state       ][INFO    ][27499] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-30 06:21:50,669 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-30 06:21:50,768 [salt.state       ][INFO    ][27499] unless execution succeeded
2017-11-30 06:21:50,770 [salt.state       ][INFO    ][27499] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 06:21:50.769837 duration_in_ms=102.247
2017-11-30 06:21:50,774 [salt.state       ][INFO    ][27499] Running state [keystone-credential-keys] at time 06:21:50.773756
2017-11-30 06:21:50,774 [salt.state       ][INFO    ][27499] Executing state glusterfs.started for keystone-credential-keys
2017-11-30 06:21:50,775 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:50,797 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:50,884 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --version' in directory '/root'
2017-11-30 06:21:50,901 [salt.loaded.int.module.cmdmod][INFO    ][27499] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-30 06:21:50,994 [salt.state       ][INFO    ][27499] Volume keystone-credential-keys is already started
2017-11-30 06:21:50,995 [salt.state       ][INFO    ][27499] Completed state [keystone-credential-keys] at time 06:21:50.994640 duration_in_ms=220.883
2017-11-30 06:21:51,000 [salt.minion      ][INFO    ][27499] Returning information for job: 20171130062141850176
2017-11-30 06:21:56,547 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command test.ping with jid 20171130062156534244
2017-11-30 06:21:56,576 [salt.minion      ][INFO    ][28060] Starting a new job with PID 28060
2017-11-30 06:21:56,619 [salt.minion      ][INFO    ][28060] Returning information for job: 20171130062156534244
2017-11-30 06:21:57,010 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command cmd.run with jid 20171130062157004906
2017-11-30 06:21:57,035 [salt.minion      ][INFO    ][28065] Starting a new job with PID 28065
2017-11-30 06:21:57,042 [salt.loaded.int.module.cmdmod][INFO    ][28065] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-30 06:21:57,220 [salt.minion      ][INFO    ][28065] Returning information for job: 20171130062157004906
2017-11-30 07:02:20,218 [salt.utils.schedule][INFO    ][21969] Running scheduled job: __mine_interval
2017-11-30 07:25:01,559 [salt.minion      ][INFO    ][21969] User sudo_ubuntu Executing command cp.push_dir with jid 20171130072501548195
2017-11-30 07:25:01,585 [salt.minion      ][INFO    ][28953] Starting a new job with PID 28953
