2017-12-02 02:17:38,666 [salt.cli.daemons ][WARNING ][2352] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-02 02:37:45,759 [salt.state       ][ERROR   ][3678] No contents found in top file
2017-12-02 02:39:17,631 [salt.utils.parsers][WARNING ][2352] Minion received a SIGTERM. Exiting.
2017-12-02 02:41:33,300 [salt.cli.daemons ][WARNING ][3257] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-02 02:44:52,102 [py.warnings      ][WARNING ][13332] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-12-02 02:59:09,950 [salt.loaded.int.module.cmdmod][ERROR   ][13332] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-02 02:59:09,951 [salt.loaded.int.module.cmdmod][ERROR   ][13332] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-02 02:59:17,451 [salt.loaded.int.module.cmdmod][ERROR   ][13332] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-02 02:59:17,451 [salt.loaded.int.module.cmdmod][ERROR   ][13332] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-02 02:59:25,907 [salt.loaded.int.module.cmdmod][ERROR   ][13332] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-02 02:59:25,907 [salt.loaded.int.module.cmdmod][ERROR   ][13332] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-02 02:59:35,000 [salt.loaded.int.module.cmdmod][ERROR   ][13332] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-02 02:59:35,001 [salt.loaded.int.module.cmdmod][ERROR   ][13332] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-02 02:59:44,253 [salt.loaded.int.module.cmdmod][ERROR   ][13332] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-02 02:59:44,254 [salt.loaded.int.module.cmdmod][ERROR   ][13332] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-02 02:59:50,022 [salt.loaded.int.module.cmdmod][ERROR   ][13332] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-12-02 02:59:53,742 [salt.state       ][ERROR   ][21172] No contents found in top file
2017-12-02 03:00:01,488 [salt.loaded.int.module.cmdmod][INFO    ][21608] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-02 03:00:01,495 [salt.loaded.int.module.cmdmod][INFO    ][21608] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-02 03:00:01,505 [salt.loaded.int.module.cmdmod][INFO    ][21608] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-02 03:00:01,513 [salt.utils.parsers][WARNING ][3257] Minion received a SIGTERM. Exiting.
2017-12-02 03:00:01,821 [salt.cli.daemons ][INFO    ][21718] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-ovs-ha.local"
2017-12-02 03:00:02,365 [salt.minion      ][INFO    ][21718] Creating minion process manager
2017-12-02 03:00:02,365 [salt.cli.daemons ][WARNING ][21718] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-02 03:00:02,365 [salt.cli.daemons ][INFO    ][21718] The Salt Minion is starting up
2017-12-02 03:00:02,366 [salt.minion      ][INFO    ][21718] Minion is starting as user 'root'
2017-12-02 03:00:02,366 [salt.utils.event ][INFO    ][21718] Starting pull socket on /var/run/salt/minion/minion_event_fd678c5357_pull.ipc
2017-12-02 03:00:03,254 [salt.loaded.int.module.cmdmod][INFO    ][21718] Executing command ['date', '+%z'] in directory '/root'
2017-12-02 03:00:03,264 [salt.utils.schedule][INFO    ][21718] Updating job settings for scheduled job: __mine_interval
2017-12-02 03:00:03,266 [salt.minion      ][INFO    ][21718] Added mine.update to scheduler
2017-12-02 03:00:03,476 [salt.minion      ][INFO    ][21718] Minion is ready to receive requests!
2017-12-02 03:00:04,477 [salt.utils.schedule][INFO    ][21718] Running scheduled job: __mine_interval
2017-12-02 03:00:10,728 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command saltutil.find_job with jid 20171202030010714849
2017-12-02 03:00:10,743 [salt.minion      ][INFO    ][21819] Starting a new job with PID 21819
2017-12-02 03:00:10,751 [salt.minion      ][INFO    ][21819] Returning information for job: 20171202030010714849
2017-12-02 03:00:31,758 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command state.sls with jid 20171202030031748953
2017-12-02 03:00:31,773 [salt.minion      ][INFO    ][21827] Starting a new job with PID 21827
2017-12-02 03:00:34,381 [salt.state       ][INFO    ][21827] Loading fresh modules for state activity
2017-12-02 03:00:34,404 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-02 03:00:34,422 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-02 03:00:34,474 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 03:00:34,548 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-02 03:00:34,603 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-02 03:00:34,628 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 03:00:34,728 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-02 03:00:34,745 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-02 03:00:34,789 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-02 03:00:34,806 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-02 03:00:34,818 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-02 03:00:34,833 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-02 03:00:34,840 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-02 03:00:34,876 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-02 03:00:34,890 [py.warnings      ][WARNING ][21827] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-12-02 03:00:34,890 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'salt-minion --version' in directory '/root'
2017-12-02 03:00:35,132 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-02 03:00:35,190 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-02 03:00:35,205 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-02 03:00:35,216 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-02 03:00:35,248 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-02 03:00:35,262 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-02 03:00:35,280 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-02 03:00:35,292 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-02 03:00:35,346 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-02 03:00:35,387 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-02 03:00:35,469 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-02 03:00:35,494 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 03:00:35,550 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-02 03:00:35,568 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-02 03:00:35,610 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-02 03:00:35,629 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-02 03:00:35,641 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-02 03:00:35,656 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-02 03:00:35,662 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-02 03:00:35,686 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-02 03:00:35,702 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'salt-minion --version' in directory '/root'
2017-12-02 03:00:35,974 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-02 03:00:35,994 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-02 03:00:36,006 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-02 03:00:36,018 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-02 03:00:36,053 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-02 03:00:36,084 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-02 03:00:36,106 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-02 03:00:36,119 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-02 03:00:36,136 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-02 03:00:36,171 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-02 03:00:36,233 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-02 03:00:36,310 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 03:00:36,669 [salt.state       ][INFO    ][21827] Running state [salt-minion] at time 03:00:36.668794
2017-12-02 03:00:36,669 [salt.state       ][INFO    ][21827] Executing state pkg.installed for salt-minion
2017-12-02 03:00:36,670 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 03:00:36,920 [salt.state       ][INFO    ][21827] Package salt-minion is already installed
2017-12-02 03:00:36,920 [salt.state       ][INFO    ][21827] Completed state [salt-minion] at time 03:00:36.919771 duration_in_ms=250.976
2017-12-02 03:00:36,920 [salt.state       ][INFO    ][21827] Running state [salt_minion_dependency_packages] at time 03:00:36.919996
2017-12-02 03:00:36,920 [salt.state       ][INFO    ][21827] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-02 03:00:36,923 [salt.state       ][INFO    ][21827] All specified packages are already installed
2017-12-02 03:00:36,923 [salt.state       ][INFO    ][21827] Completed state [salt_minion_dependency_packages] at time 03:00:36.922913 duration_in_ms=2.916
2017-12-02 03:00:36,924 [salt.state       ][INFO    ][21827] Running state [/etc/salt/minion.d/minion.conf] at time 03:00:36.924371
2017-12-02 03:00:36,925 [salt.state       ][INFO    ][21827] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-02 03:00:37,023 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-02 03:00:37,070 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 03:00:37,114 [salt.fileclient  ][INFO    ][21827] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-02 03:00:37,153 [salt.state       ][INFO    ][21827] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-02 03:00:37,153 [salt.state       ][INFO    ][21827] Completed state [/etc/salt/minion.d/minion.conf] at time 03:00:37.152945 duration_in_ms=228.573
2017-12-02 03:00:37,153 [salt.state       ][INFO    ][21827] Running state [/etc/salt/minion.d/_virt.conf] at time 03:00:37.153234
2017-12-02 03:00:37,153 [salt.state       ][INFO    ][21827] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-02 03:00:37,284 [salt.state       ][INFO    ][21827] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-02 03:00:37,284 [salt.state       ][INFO    ][21827] Completed state [/etc/salt/minion.d/_virt.conf] at time 03:00:37.284218 duration_in_ms=130.983
2017-12-02 03:00:37,286 [salt.state       ][INFO    ][21827] Running state [salt-minion] at time 03:00:37.285881
2017-12-02 03:00:37,286 [salt.state       ][INFO    ][21827] Executing state service.running for salt-minion
2017-12-02 03:00:37,287 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-02 03:00:37,303 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-02 03:00:37,362 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-02 03:00:37,369 [salt.state       ][INFO    ][21827] The service salt-minion is already running
2017-12-02 03:00:37,369 [salt.state       ][INFO    ][21827] Completed state [salt-minion] at time 03:00:37.368986 duration_in_ms=83.104
2017-12-02 03:00:37,370 [salt.state       ][INFO    ][21827] Running state [/etc/salt/grains.d] at time 03:00:37.370430
2017-12-02 03:00:37,371 [salt.state       ][INFO    ][21827] Executing state file.directory for /etc/salt/grains.d
2017-12-02 03:00:37,371 [salt.state       ][INFO    ][21827] Directory /etc/salt/grains.d is in the correct state
2017-12-02 03:00:37,372 [salt.state       ][INFO    ][21827] Completed state [/etc/salt/grains.d] at time 03:00:37.371486 duration_in_ms=1.055
2017-12-02 03:00:37,372 [salt.state       ][INFO    ][21827] Running state [/etc/salt/grains] at time 03:00:37.371953
2017-12-02 03:00:37,372 [salt.state       ][INFO    ][21827] Executing state file.managed for /etc/salt/grains
2017-12-02 03:00:37,373 [salt.state       ][INFO    ][21827] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-02 03:00:37,373 [salt.state       ][INFO    ][21827] Completed state [/etc/salt/grains] at time 03:00:37.372733 duration_in_ms=0.78
2017-12-02 03:00:37,373 [salt.state       ][INFO    ][21827] Running state [/etc/salt/grains.d/placeholder] at time 03:00:37.373037
2017-12-02 03:00:37,373 [salt.state       ][INFO    ][21827] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-02 03:00:37,374 [salt.state       ][INFO    ][21827] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-02 03:00:37,374 [salt.state       ][INFO    ][21827] Completed state [/etc/salt/grains.d/placeholder] at time 03:00:37.373788 duration_in_ms=0.752
2017-12-02 03:00:37,374 [salt.state       ][INFO    ][21827] Running state [/etc/salt/grains.d/sphinx] at time 03:00:37.374093
2017-12-02 03:00:37,374 [salt.state       ][INFO    ][21827] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-02 03:00:37,491 [salt.state       ][INFO    ][21827] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.141
               - 127.0.0.1
               - 192.168.11.251
-              - 192.168.122.1
         system:
           name: System
           param:

2017-12-02 03:00:37,491 [salt.state       ][INFO    ][21827] Completed state [/etc/salt/grains.d/sphinx] at time 03:00:37.491164 duration_in_ms=117.069
2017-12-02 03:00:37,492 [salt.state       ][INFO    ][21827] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:00:37.491815
2017-12-02 03:00:37,492 [salt.state       ][INFO    ][21827] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-02 03:00:37,492 [salt.state       ][INFO    ][21827] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-02 03:00:37,492 [salt.state       ][INFO    ][21827] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:00:37.492340 duration_in_ms=0.524
2017-12-02 03:00:37,492 [salt.state       ][INFO    ][21827] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:00:37.492465
2017-12-02 03:00:37,493 [salt.state       ][INFO    ][21827] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-02 03:00:37,493 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-12-02 03:00:37,582 [salt.state       ][INFO    ][21827] {'pid': 21876, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-02 03:00:37,583 [salt.state       ][INFO    ][21827] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:00:37.582532 duration_in_ms=90.066
2017-12-02 03:00:37,583 [salt.state       ][INFO    ][21827] Running state [/etc/salt/grains.d/dns_records] at time 03:00:37.582961
2017-12-02 03:00:37,583 [salt.state       ][INFO    ][21827] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-02 03:00:37,616 [salt.state       ][INFO    ][21827] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-02 03:00:37,617 [salt.state       ][INFO    ][21827] Completed state [/etc/salt/grains.d/dns_records] at time 03:00:37.616627 duration_in_ms=33.666
2017-12-02 03:00:37,617 [salt.state       ][INFO    ][21827] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 03:00:37.617263
2017-12-02 03:00:37,617 [salt.state       ][INFO    ][21827] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-02 03:00:37,618 [salt.state       ][INFO    ][21827] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-02 03:00:37,618 [salt.state       ][INFO    ][21827] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 03:00:37.617809 duration_in_ms=0.545
2017-12-02 03:00:37,618 [salt.state       ][INFO    ][21827] Running state [/etc/salt/grains.d/salt] at time 03:00:37.618085
2017-12-02 03:00:37,618 [salt.state       ][INFO    ][21827] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-02 03:00:37,752 [salt.state       ][INFO    ][21827] File /etc/salt/grains.d/salt is in the correct state
2017-12-02 03:00:37,752 [salt.state       ][INFO    ][21827] Completed state [/etc/salt/grains.d/salt] at time 03:00:37.751836 duration_in_ms=133.751
2017-12-02 03:00:37,753 [salt.state       ][INFO    ][21827] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 03:00:37.752475
2017-12-02 03:00:37,753 [salt.state       ][INFO    ][21827] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-02 03:00:37,753 [salt.state       ][INFO    ][21827] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-02 03:00:37,753 [salt.state       ][INFO    ][21827] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 03:00:37.753111 duration_in_ms=0.636
2017-12-02 03:00:37,754 [salt.state       ][INFO    ][21827] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:00:37.754410
2017-12-02 03:00:37,755 [salt.state       ][INFO    ][21827] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-02 03:00:37,755 [salt.state       ][INFO    ][21827] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-02 03:00:37,755 [salt.state       ][INFO    ][21827] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:00:37.755054 duration_in_ms=0.643
2017-12-02 03:00:37,755 [salt.state       ][INFO    ][21827] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:00:37.755218
2017-12-02 03:00:37,755 [salt.state       ][INFO    ][21827] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-02 03:00:37,757 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-12-02 03:00:37,765 [salt.state       ][INFO    ][21827] {'pid': 21878, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-02 03:00:37,765 [salt.state       ][INFO    ][21827] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:00:37.764853 duration_in_ms=9.634
2017-12-02 03:00:37,765 [salt.state       ][INFO    ][21827] Running state [mine.update] at time 03:00:37.765431
2017-12-02 03:00:37,766 [salt.state       ][INFO    ][21827] Executing state module.wait for mine.update
2017-12-02 03:00:37,766 [salt.state       ][INFO    ][21827] No changes made for mine.update
2017-12-02 03:00:37,766 [salt.state       ][INFO    ][21827] Completed state [mine.update] at time 03:00:37.766050 duration_in_ms=0.62
2017-12-02 03:00:37,766 [salt.state       ][INFO    ][21827] Running state [mine.update] at time 03:00:37.766201
2017-12-02 03:00:37,766 [salt.state       ][INFO    ][21827] Executing state module.mod_watch for mine.update
2017-12-02 03:00:38,284 [salt.state       ][INFO    ][21827] {'ret': True}
2017-12-02 03:00:38,284 [salt.state       ][INFO    ][21827] Completed state [mine.update] at time 03:00:38.283794 duration_in_ms=517.592
2017-12-02 03:00:38,284 [salt.state       ][INFO    ][21827] Running state [ca-certificates] at time 03:00:38.284046
2017-12-02 03:00:38,284 [salt.state       ][INFO    ][21827] Executing state pkg.installed for ca-certificates
2017-12-02 03:00:38,288 [salt.state       ][INFO    ][21827] Package ca-certificates is already installed
2017-12-02 03:00:38,288 [salt.state       ][INFO    ][21827] Completed state [ca-certificates] at time 03:00:38.287749 duration_in_ms=3.702
2017-12-02 03:00:38,288 [salt.state       ][INFO    ][21827] Running state [update-ca-certificates] at time 03:00:38.288318
2017-12-02 03:00:38,289 [salt.state       ][INFO    ][21827] Executing state cmd.wait for update-ca-certificates
2017-12-02 03:00:38,289 [salt.state       ][INFO    ][21827] No changes made for update-ca-certificates
2017-12-02 03:00:38,289 [salt.state       ][INFO    ][21827] Completed state [update-ca-certificates] at time 03:00:38.288940 duration_in_ms=0.622
2017-12-02 03:00:38,289 [salt.state       ][INFO    ][21827] Running state [libvirt-dev] at time 03:00:38.289132
2017-12-02 03:00:38,289 [salt.state       ][INFO    ][21827] Executing state pkg.installed for libvirt-dev
2017-12-02 03:00:38,292 [salt.state       ][INFO    ][21827] Package libvirt-dev is already installed
2017-12-02 03:00:38,292 [salt.state       ][INFO    ][21827] Completed state [libvirt-dev] at time 03:00:38.292211 duration_in_ms=3.079
2017-12-02 03:00:38,292 [salt.state       ][INFO    ][21827] Running state [pkg-config] at time 03:00:38.292399
2017-12-02 03:00:38,293 [salt.state       ][INFO    ][21827] Executing state pkg.installed for pkg-config
2017-12-02 03:00:38,295 [salt.state       ][INFO    ][21827] Package pkg-config is already installed
2017-12-02 03:00:38,296 [salt.state       ][INFO    ][21827] Completed state [pkg-config] at time 03:00:38.295513 duration_in_ms=3.113
2017-12-02 03:00:38,296 [salt.state       ][INFO    ][21827] Running state [virtng.init] at time 03:00:38.295704
2017-12-02 03:00:38,296 [salt.state       ][INFO    ][21827] Executing state module.run for virtng.init
2017-12-02 03:00:38,378 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command ['git', '--version'] in directory '/root'
2017-12-02 03:00:38,530 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-02 03:00:38,548 [salt.state       ][INFO    ][21827] unless execution succeeded
2017-12-02 03:00:38,548 [salt.state       ][INFO    ][21827] Completed state [virtng.init] at time 03:00:38.547986 duration_in_ms=252.28
2017-12-02 03:00:38,548 [salt.state       ][INFO    ][21827] Running state [virt.set_autostart] at time 03:00:38.548246
2017-12-02 03:00:38,548 [salt.state       ][INFO    ][21827] Executing state module.run for virt.set_autostart
2017-12-02 03:00:38,550 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-02 03:00:38,566 [salt.state       ][INFO    ][21827] unless execution succeeded
2017-12-02 03:00:38,566 [salt.state       ][INFO    ][21827] Completed state [virt.set_autostart] at time 03:00:38.565992 duration_in_ms=17.745
2017-12-02 03:00:38,566 [salt.state       ][INFO    ][21827] Running state [virtng.init] at time 03:00:38.566229
2017-12-02 03:00:38,566 [salt.state       ][INFO    ][21827] Executing state module.run for virtng.init
2017-12-02 03:00:38,568 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-02 03:00:38,584 [salt.state       ][INFO    ][21827] unless execution succeeded
2017-12-02 03:00:38,584 [salt.state       ][INFO    ][21827] Completed state [virtng.init] at time 03:00:38.583822 duration_in_ms=17.591
2017-12-02 03:00:38,584 [salt.state       ][INFO    ][21827] Running state [virt.set_autostart] at time 03:00:38.584060
2017-12-02 03:00:38,584 [salt.state       ][INFO    ][21827] Executing state module.run for virt.set_autostart
2017-12-02 03:00:38,586 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-02 03:00:38,601 [salt.state       ][INFO    ][21827] unless execution succeeded
2017-12-02 03:00:38,601 [salt.state       ][INFO    ][21827] Completed state [virt.set_autostart] at time 03:00:38.600841 duration_in_ms=16.779
2017-12-02 03:00:38,601 [salt.state       ][INFO    ][21827] Running state [virtng.init] at time 03:00:38.601072
2017-12-02 03:00:38,601 [salt.state       ][INFO    ][21827] Executing state module.run for virtng.init
2017-12-02 03:00:38,603 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-02 03:00:38,617 [salt.state       ][INFO    ][21827] unless execution succeeded
2017-12-02 03:00:38,617 [salt.state       ][INFO    ][21827] Completed state [virtng.init] at time 03:00:38.616812 duration_in_ms=15.739
2017-12-02 03:00:38,617 [salt.state       ][INFO    ][21827] Running state [virt.set_autostart] at time 03:00:38.617036
2017-12-02 03:00:38,617 [salt.state       ][INFO    ][21827] Executing state module.run for virt.set_autostart
2017-12-02 03:00:38,619 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-02 03:00:38,633 [salt.state       ][INFO    ][21827] unless execution succeeded
2017-12-02 03:00:38,633 [salt.state       ][INFO    ][21827] Completed state [virt.set_autostart] at time 03:00:38.632991 duration_in_ms=15.954
2017-12-02 03:00:38,633 [salt.state       ][INFO    ][21827] Running state [virtng.init] at time 03:00:38.633213
2017-12-02 03:00:38,633 [salt.state       ][INFO    ][21827] Executing state module.run for virtng.init
2017-12-02 03:00:38,635 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-02 03:00:38,650 [salt.state       ][INFO    ][21827] unless execution succeeded
2017-12-02 03:00:38,747 [salt.state       ][INFO    ][21827] Completed state [virtng.init] at time 03:00:38.747270 duration_in_ms=114.056
2017-12-02 03:00:38,748 [salt.state       ][INFO    ][21827] Running state [virt.set_autostart] at time 03:00:38.747547
2017-12-02 03:00:38,748 [salt.state       ][INFO    ][21827] Executing state module.run for virt.set_autostart
2017-12-02 03:00:38,750 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-02 03:00:38,764 [salt.state       ][INFO    ][21827] unless execution succeeded
2017-12-02 03:00:38,765 [salt.state       ][INFO    ][21827] Completed state [virt.set_autostart] at time 03:00:38.764596 duration_in_ms=17.048
2017-12-02 03:00:38,765 [salt.state       ][INFO    ][21827] Running state [virtng.init] at time 03:00:38.764830
2017-12-02 03:00:38,765 [salt.state       ][INFO    ][21827] Executing state module.run for virtng.init
2017-12-02 03:00:38,767 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-02 03:00:38,781 [salt.state       ][INFO    ][21827] unless execution succeeded
2017-12-02 03:00:38,782 [salt.state       ][INFO    ][21827] Completed state [virtng.init] at time 03:00:38.781688 duration_in_ms=16.857
2017-12-02 03:00:38,782 [salt.state       ][INFO    ][21827] Running state [virt.set_autostart] at time 03:00:38.781920
2017-12-02 03:00:38,782 [salt.state       ][INFO    ][21827] Executing state module.run for virt.set_autostart
2017-12-02 03:00:38,784 [salt.loaded.int.module.cmdmod][INFO    ][21827] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-02 03:00:38,798 [salt.state       ][INFO    ][21827] unless execution succeeded
2017-12-02 03:00:38,798 [salt.state       ][INFO    ][21827] Completed state [virt.set_autostart] at time 03:00:38.798423 duration_in_ms=16.503
2017-12-02 03:00:38,800 [salt.minion      ][INFO    ][21827] Returning information for job: 20171202030031748953
2017-12-02 03:00:39,665 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command pillar.get with jid 20171202030039650222
2017-12-02 03:00:39,678 [salt.minion      ][INFO    ][21931] Starting a new job with PID 21931
2017-12-02 03:00:39,680 [salt.minion      ][INFO    ][21931] Returning information for job: 20171202030039650222
2017-12-02 03:01:18,328 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171202030118314278
2017-12-02 03:01:18,346 [salt.minion      ][INFO    ][21945] Starting a new job with PID 21945
2017-12-02 03:01:21,337 [salt.state       ][INFO    ][21945] Loading fresh modules for state activity
2017-12-02 03:01:21,357 [salt.state       ][ERROR   ][21945] No contents found in top file
2017-12-02 03:01:21,358 [salt.utils.extmods][INFO    ][21945] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-02 03:01:21,360 [salt.utils.extmods][INFO    ][21945] Syncing beacons for environment 'base'
2017-12-02 03:01:21,361 [salt.utils.extmods][INFO    ][21945] Loading cache from salt://_beacons, for base)
2017-12-02 03:01:21,361 [salt.fileclient  ][INFO    ][21945] Caching directory '_beacons/' for environment 'base'
2017-12-02 03:01:21,457 [salt.utils.extmods][INFO    ][21945] Syncing modules for environment 'base'
2017-12-02 03:01:21,458 [salt.utils.extmods][INFO    ][21945] Loading cache from salt://_modules, for base)
2017-12-02 03:01:21,458 [salt.fileclient  ][INFO    ][21945] Caching directory '_modules/' for environment 'base'
2017-12-02 03:01:21,926 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-02 03:01:21,937 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-02 03:01:22,037 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-02 03:01:22,069 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-02 03:01:22,091 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-02 03:01:22,121 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-02 03:01:22,140 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-02 03:01:22,153 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-02 03:01:22,169 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-02 03:01:22,199 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-02 03:01:22,225 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-02 03:01:22,241 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-02 03:01:22,256 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-02 03:01:22,284 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-02 03:01:22,295 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-02 03:01:22,325 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-02 03:01:22,340 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-02 03:01:22,380 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-02 03:01:22,389 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-02 03:01:22,410 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-02 03:01:22,435 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-02 03:01:22,465 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-02 03:01:22,487 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-02 03:01:22,501 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-02 03:01:22,517 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-02 03:01:22,530 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-02 03:01:22,566 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-02 03:01:22,576 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-02 03:01:22,585 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-02 03:01:22,630 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-02 03:01:22,639 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-02 03:01:22,655 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-02 03:01:22,714 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-02 03:01:22,734 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-02 03:01:22,737 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-02 03:01:22,737 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-02 03:01:22,738 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-02 03:01:22,738 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-02 03:01:22,738 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-02 03:01:22,739 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-02 03:01:22,739 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-02 03:01:22,739 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-02 03:01:22,740 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-02 03:01:22,740 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-02 03:01:22,740 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-02 03:01:22,740 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-02 03:01:22,740 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-02 03:01:22,741 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-02 03:01:22,741 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-02 03:01:22,741 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-02 03:01:22,741 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-02 03:01:22,741 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-02 03:01:22,742 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-02 03:01:22,742 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-02 03:01:22,742 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-02 03:01:22,742 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-02 03:01:22,743 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-02 03:01:22,743 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-02 03:01:22,743 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-02 03:01:22,743 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-02 03:01:22,744 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-02 03:01:22,744 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-02 03:01:22,744 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-02 03:01:22,744 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-02 03:01:22,744 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-02 03:01:22,745 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-02 03:01:22,745 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-02 03:01:22,745 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-12-02 03:01:22,745 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-02 03:01:22,745 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-02 03:01:22,750 [salt.utils.extmods][INFO    ][21945] Syncing states for environment 'base'
2017-12-02 03:01:22,750 [salt.utils.extmods][INFO    ][21945] Loading cache from salt://_states, for base)
2017-12-02 03:01:22,751 [salt.fileclient  ][INFO    ][21945] Caching directory '_states/' for environment 'base'
2017-12-02 03:01:22,818 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-02 03:01:22,828 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-02 03:01:22,837 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-02 03:01:22,848 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-02 03:01:22,862 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-02 03:01:22,880 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-02 03:01:22,891 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-02 03:01:22,941 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-02 03:01:22,963 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-02 03:01:22,972 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-02 03:01:22,998 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-02 03:01:23,009 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-02 03:01:23,016 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-02 03:01:23,026 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-02 03:01:23,047 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-02 03:01:23,063 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-02 03:01:23,090 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-02 03:01:23,101 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-02 03:01:23,112 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-02 03:01:23,145 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-02 03:01:23,156 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-02 03:01:23,170 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-02 03:01:23,182 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-02 03:01:23,193 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-02 03:01:23,249 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-02 03:01:23,267 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-02 03:01:23,289 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-02 03:01:23,300 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-02 03:01:23,312 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-02 03:01:23,348 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-02 03:01:23,361 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-02 03:01:23,416 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-02 03:01:23,419 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-02 03:01:23,419 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-02 03:01:23,419 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-02 03:01:23,419 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-02 03:01:23,419 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-02 03:01:23,420 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-02 03:01:23,420 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-02 03:01:23,420 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-02 03:01:23,420 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-02 03:01:23,421 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-02 03:01:23,421 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-02 03:01:23,421 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-02 03:01:23,421 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-02 03:01:23,421 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-02 03:01:23,421 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-02 03:01:23,422 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-02 03:01:23,422 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-02 03:01:23,422 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-02 03:01:23,422 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-02 03:01:23,422 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-02 03:01:23,423 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-02 03:01:23,423 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-02 03:01:23,423 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-02 03:01:23,423 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-02 03:01:23,423 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-02 03:01:23,424 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-02 03:01:23,424 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-02 03:01:23,424 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-02 03:01:23,424 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-02 03:01:23,424 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-02 03:01:23,425 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-02 03:01:23,425 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-02 03:01:23,425 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-02 03:01:23,427 [salt.utils.extmods][INFO    ][21945] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-02 03:01:23,430 [salt.utils.extmods][INFO    ][21945] Syncing sdb for environment 'base'
2017-12-02 03:01:23,430 [salt.utils.extmods][INFO    ][21945] Loading cache from salt://_sdb, for base)
2017-12-02 03:01:23,430 [salt.fileclient  ][INFO    ][21945] Caching directory '_sdb/' for environment 'base'
2017-12-02 03:01:23,494 [salt.utils.extmods][INFO    ][21945] Syncing grains for environment 'base'
2017-12-02 03:01:23,494 [salt.utils.extmods][INFO    ][21945] Loading cache from salt://_grains, for base)
2017-12-02 03:01:23,494 [salt.fileclient  ][INFO    ][21945] Caching directory '_grains/' for environment 'base'
2017-12-02 03:01:23,526 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-02 03:01:23,537 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-02 03:01:23,548 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-02 03:01:23,561 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-02 03:01:23,577 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-02 03:01:23,586 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-02 03:01:23,598 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-02 03:01:23,611 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-02 03:01:23,625 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-02 03:01:23,635 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-02 03:01:23,653 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-02 03:01:23,662 [salt.fileclient  ][INFO    ][21945] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-02 03:01:23,665 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-02 03:01:23,689 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-02 03:01:23,689 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-02 03:01:23,689 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-02 03:01:23,690 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-02 03:01:23,690 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-02 03:01:23,690 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-02 03:01:23,690 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-02 03:01:23,691 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-02 03:01:23,691 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-02 03:01:23,691 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-02 03:01:23,691 [salt.utils.extmods][INFO    ][21945] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-02 03:01:23,692 [salt.utils.extmods][INFO    ][21945] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-02 03:01:23,695 [salt.utils.extmods][INFO    ][21945] Syncing renderers for environment 'base'
2017-12-02 03:01:23,710 [salt.utils.extmods][INFO    ][21945] Loading cache from salt://_renderers, for base)
2017-12-02 03:01:23,710 [salt.fileclient  ][INFO    ][21945] Caching directory '_renderers/' for environment 'base'
2017-12-02 03:01:23,741 [salt.utils.extmods][INFO    ][21945] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-02 03:01:23,743 [salt.utils.extmods][INFO    ][21945] Syncing returners for environment 'base'
2017-12-02 03:01:23,743 [salt.utils.extmods][INFO    ][21945] Loading cache from salt://_returners, for base)
2017-12-02 03:01:23,743 [salt.fileclient  ][INFO    ][21945] Caching directory '_returners/' for environment 'base'
2017-12-02 03:01:23,789 [salt.utils.extmods][INFO    ][21945] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-02 03:01:23,791 [salt.utils.extmods][INFO    ][21945] Syncing output for environment 'base'
2017-12-02 03:01:23,791 [salt.utils.extmods][INFO    ][21945] Loading cache from salt://_output, for base)
2017-12-02 03:01:23,791 [salt.fileclient  ][INFO    ][21945] Caching directory '_output/' for environment 'base'
2017-12-02 03:01:23,821 [salt.utils.extmods][INFO    ][21945] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-02 03:01:23,824 [salt.utils.extmods][INFO    ][21945] Syncing utils for environment 'base'
2017-12-02 03:01:23,824 [salt.utils.extmods][INFO    ][21945] Loading cache from salt://_utils, for base)
2017-12-02 03:01:23,824 [salt.fileclient  ][INFO    ][21945] Caching directory '_utils/' for environment 'base'
2017-12-02 03:01:23,848 [salt.utils.extmods][INFO    ][21945] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-02 03:01:23,850 [salt.utils.extmods][INFO    ][21945] Syncing log_handlers for environment 'base'
2017-12-02 03:01:23,850 [salt.utils.extmods][INFO    ][21945] Loading cache from salt://_log_handlers, for base)
2017-12-02 03:01:23,850 [salt.fileclient  ][INFO    ][21945] Caching directory '_log_handlers/' for environment 'base'
2017-12-02 03:01:23,881 [salt.utils.extmods][INFO    ][21945] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-02 03:01:23,884 [salt.utils.extmods][INFO    ][21945] Syncing proxy for environment 'base'
2017-12-02 03:01:23,884 [salt.utils.extmods][INFO    ][21945] Loading cache from salt://_proxy, for base)
2017-12-02 03:01:23,884 [salt.fileclient  ][INFO    ][21945] Caching directory '_proxy/' for environment 'base'
2017-12-02 03:01:23,914 [salt.utils.extmods][INFO    ][21945] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-02 03:01:23,916 [salt.utils.extmods][INFO    ][21945] Syncing engines for environment 'base'
2017-12-02 03:01:23,916 [salt.utils.extmods][INFO    ][21945] Loading cache from salt://_engines, for base)
2017-12-02 03:01:23,917 [salt.fileclient  ][INFO    ][21945] Caching directory '_engines/' for environment 'base'
2017-12-02 03:01:23,968 [salt.minion      ][INFO    ][21945] Returning information for job: 20171202030118314278
2017-12-02 03:12:37,079 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command test.ping with jid 20171202031237066665
2017-12-02 03:12:37,096 [salt.minion      ][INFO    ][22124] Starting a new job with PID 22124
2017-12-02 03:12:37,121 [salt.minion      ][INFO    ][22124] Returning information for job: 20171202031237066665
2017-12-02 03:16:26,156 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command state.sls with jid 20171202031626141960
2017-12-02 03:16:26,171 [salt.minion      ][INFO    ][22182] Starting a new job with PID 22182
2017-12-02 03:16:27,709 [salt.state       ][INFO    ][22182] Loading fresh modules for state activity
2017-12-02 03:16:27,804 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-02 03:16:27,820 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-02 03:16:27,844 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-02 03:16:28,143 [salt.state       ][INFO    ][22182] Running state [lsof] at time 03:16:28.142603
2017-12-02 03:16:28,143 [salt.state       ][INFO    ][22182] Executing state pkg.installed for lsof
2017-12-02 03:16:28,143 [salt.loaded.int.module.cmdmod][INFO    ][22182] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 03:16:28,410 [salt.state       ][INFO    ][22182] Package lsof is already installed
2017-12-02 03:16:28,411 [salt.state       ][INFO    ][22182] Completed state [lsof] at time 03:16:28.410634 duration_in_ms=268.032
2017-12-02 03:16:28,411 [salt.state       ][INFO    ][22182] Running state [keepalived] at time 03:16:28.410836
2017-12-02 03:16:28,411 [salt.state       ][INFO    ][22182] Executing state pkg.installed for keepalived
2017-12-02 03:16:28,426 [salt.loaded.int.module.cmdmod][INFO    ][22182] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-02 03:16:30,367 [salt.loaded.int.module.cmdmod][INFO    ][22182] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-12-02 03:16:36,199 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command saltutil.find_job with jid 20171202031636185042
2017-12-02 03:16:36,213 [salt.minion      ][INFO    ][23391] Starting a new job with PID 23391
2017-12-02 03:16:36,227 [salt.minion      ][INFO    ][23391] Returning information for job: 20171202031636185042
2017-12-02 03:16:37,755 [salt.loaded.int.module.cmdmod][INFO    ][22182] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 03:16:37,780 [salt.state       ][INFO    ][22182] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-12-02 03:16:37,788 [salt.state       ][INFO    ][22182] Loading fresh modules for state activity
2017-12-02 03:16:37,800 [salt.state       ][INFO    ][22182] Completed state [keepalived] at time 03:16:37.800412 duration_in_ms=9389.575
2017-12-02 03:16:37,802 [salt.state       ][INFO    ][22182] Running state [/etc/keepalived/keepalived.conf] at time 03:16:37.802265
2017-12-02 03:16:37,802 [salt.state       ][INFO    ][22182] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-02 03:16:37,828 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-02 03:16:37,862 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-02 03:16:37,869 [salt.state       ][INFO    ][22182] File changed:
New file
2017-12-02 03:16:37,869 [salt.state       ][INFO    ][22182] Completed state [/etc/keepalived/keepalived.conf] at time 03:16:37.868851 duration_in_ms=66.585
2017-12-02 03:16:37,928 [salt.state       ][INFO    ][22182] Running state [keepalived] at time 03:16:37.927665
2017-12-02 03:16:37,928 [salt.state       ][INFO    ][22182] Executing state service.running for keepalived
2017-12-02 03:16:37,929 [salt.loaded.int.module.cmdmod][INFO    ][22182] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-02 03:16:37,939 [salt.loaded.int.module.cmdmod][INFO    ][22182] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-02 03:16:37,947 [salt.loaded.int.module.cmdmod][INFO    ][22182] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-02 03:16:37,956 [salt.loaded.int.module.cmdmod][INFO    ][22182] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-02 03:16:37,965 [salt.loaded.int.module.cmdmod][INFO    ][22182] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-12-02 03:16:38,018 [salt.loaded.int.module.cmdmod][INFO    ][22182] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-02 03:16:38,027 [salt.loaded.int.module.cmdmod][INFO    ][22182] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-02 03:16:38,035 [salt.loaded.int.module.cmdmod][INFO    ][22182] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-02 03:16:38,042 [salt.state       ][INFO    ][22182] {'keepalived': True}
2017-12-02 03:16:38,042 [salt.state       ][INFO    ][22182] Completed state [keepalived] at time 03:16:38.042192 duration_in_ms=114.527
2017-12-02 03:16:38,043 [salt.minion      ][INFO    ][22182] Returning information for job: 20171202031626141960
2017-12-02 03:16:38,929 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command pillar.get with jid 20171202031638915956
2017-12-02 03:16:38,949 [salt.minion      ][INFO    ][23596] Starting a new job with PID 23596
2017-12-02 03:16:38,957 [salt.minion      ][INFO    ][23596] Returning information for job: 20171202031638915956
2017-12-02 03:21:50,557 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command state.sls with jid 20171202032150542625
2017-12-02 03:21:50,573 [salt.minion      ][INFO    ][23697] Starting a new job with PID 23697
2017-12-02 03:21:53,055 [salt.state       ][INFO    ][23697] Loading fresh modules for state activity
2017-12-02 03:21:53,077 [salt.fileclient  ][INFO    ][23697] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-02 03:21:53,110 [salt.fileclient  ][INFO    ][23697] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-02 03:21:53,374 [salt.state       ][INFO    ][23697] Running state [attr] at time 03:21:53.374210
2017-12-02 03:21:53,374 [salt.state       ][INFO    ][23697] Executing state pkg.installed for attr
2017-12-02 03:21:53,375 [salt.loaded.int.module.cmdmod][INFO    ][23697] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 03:21:53,647 [salt.loaded.int.module.cmdmod][INFO    ][23697] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-02 03:21:55,432 [salt.loaded.int.module.cmdmod][INFO    ][23697] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-12-02 03:21:57,884 [salt.loaded.int.module.cmdmod][INFO    ][23697] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 03:21:57,907 [salt.state       ][INFO    ][23697] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-12-02 03:21:57,915 [salt.state       ][INFO    ][23697] Loading fresh modules for state activity
2017-12-02 03:21:57,927 [salt.state       ][INFO    ][23697] Completed state [attr] at time 03:21:57.926503 duration_in_ms=4552.292
2017-12-02 03:21:57,933 [salt.state       ][INFO    ][23697] Running state [glusterfs-server] at time 03:21:57.933431
2017-12-02 03:21:57,934 [salt.state       ][INFO    ][23697] Executing state pkg.installed for glusterfs-server
2017-12-02 03:21:58,123 [salt.loaded.int.module.cmdmod][INFO    ][23697] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-12-02 03:22:00,650 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command saltutil.find_job with jid 20171202032200635378
2017-12-02 03:22:00,664 [salt.minion      ][INFO    ][24526] Starting a new job with PID 24526
2017-12-02 03:22:00,676 [salt.minion      ][INFO    ][24526] Returning information for job: 20171202032200635378
2017-12-02 03:22:10,846 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command saltutil.find_job with jid 20171202032210831547
2017-12-02 03:22:10,862 [salt.minion      ][INFO    ][24532] Starting a new job with PID 24532
2017-12-02 03:22:10,872 [salt.minion      ][INFO    ][24532] Returning information for job: 20171202032210831547
2017-12-02 03:22:21,042 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command saltutil.find_job with jid 20171202032221027115
2017-12-02 03:22:21,056 [salt.minion      ][INFO    ][25422] Starting a new job with PID 25422
2017-12-02 03:22:21,072 [salt.minion      ][INFO    ][25422] Returning information for job: 20171202032221027115
2017-12-02 03:22:28,367 [salt.loaded.int.module.cmdmod][INFO    ][23697] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 03:22:28,392 [salt.state       ][INFO    ][23697] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'glusterfs-client' changed from 'absent' to '3.10.8-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.8-ubuntu1~xenial1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'portmap' changed from 'absent' to '1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'
'nfs-client' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.10.8-ubuntu1~xenial1'

2017-12-02 03:22:28,399 [salt.state       ][INFO    ][23697] Loading fresh modules for state activity
2017-12-02 03:22:28,411 [salt.state       ][INFO    ][23697] Completed state [glusterfs-server] at time 03:22:28.410856 duration_in_ms=30477.424
2017-12-02 03:22:28,415 [salt.state       ][INFO    ][23697] Running state [bc] at time 03:22:28.415410
2017-12-02 03:22:28,416 [salt.state       ][INFO    ][23697] Executing state pkg.installed for bc
2017-12-02 03:22:28,666 [salt.loaded.int.module.cmdmod][INFO    ][23697] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-12-02 03:22:31,147 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command saltutil.find_job with jid 20171202032231133534
2017-12-02 03:22:31,159 [salt.minion      ][INFO    ][26445] Starting a new job with PID 26445
2017-12-02 03:22:31,169 [salt.minion      ][INFO    ][26445] Returning information for job: 20171202032231133534
2017-12-02 03:22:31,509 [salt.loaded.int.module.cmdmod][INFO    ][23697] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 03:22:31,537 [salt.state       ][INFO    ][23697] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-12-02 03:22:31,547 [salt.state       ][INFO    ][23697] Loading fresh modules for state activity
2017-12-02 03:22:31,560 [salt.state       ][INFO    ][23697] Completed state [bc] at time 03:22:31.560396 duration_in_ms=3144.985
2017-12-02 03:22:31,632 [salt.state       ][INFO    ][23697] Running state [glusterfs-server] at time 03:22:31.632036
2017-12-02 03:22:31,632 [salt.state       ][INFO    ][23697] Executing state service.running for glusterfs-server
2017-12-02 03:22:31,634 [salt.loaded.int.module.cmdmod][INFO    ][23697] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-02 03:22:31,643 [salt.loaded.int.module.cmdmod][INFO    ][23697] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-02 03:22:31,651 [salt.loaded.int.module.cmdmod][INFO    ][23697] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-02 03:22:31,660 [salt.state       ][INFO    ][23697] The service glusterfs-server is already running
2017-12-02 03:22:31,660 [salt.state       ][INFO    ][23697] Completed state [glusterfs-server] at time 03:22:31.659920 duration_in_ms=27.883
2017-12-02 03:22:31,661 [salt.state       ][INFO    ][23697] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:22:31.661410
2017-12-02 03:22:31,662 [salt.state       ][INFO    ][23697] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-02 03:22:31,674 [salt.state       ][INFO    ][23697] File changed:
New file
2017-12-02 03:22:31,675 [salt.state       ][INFO    ][23697] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:22:31.674495 duration_in_ms=13.085
2017-12-02 03:22:31,675 [salt.state       ][INFO    ][23697] Running state [/srv/glusterfs/glance] at time 03:22:31.674661
2017-12-02 03:22:31,675 [salt.state       ][INFO    ][23697] Executing state file.directory for /srv/glusterfs/glance
2017-12-02 03:22:31,675 [salt.state       ][INFO    ][23697] {'/srv/glusterfs/glance': 'New Dir'}
2017-12-02 03:22:31,676 [salt.state       ][INFO    ][23697] Completed state [/srv/glusterfs/glance] at time 03:22:31.675570 duration_in_ms=0.91
2017-12-02 03:22:31,676 [salt.state       ][INFO    ][23697] Running state [/srv/glusterfs/keystone-keys] at time 03:22:31.675755
2017-12-02 03:22:31,676 [salt.state       ][INFO    ][23697] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-02 03:22:31,676 [salt.state       ][INFO    ][23697] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-12-02 03:22:31,677 [salt.state       ][INFO    ][23697] Completed state [/srv/glusterfs/keystone-keys] at time 03:22:31.676482 duration_in_ms=0.727
2017-12-02 03:22:31,677 [salt.state       ][INFO    ][23697] Running state [/srv/glusterfs/nova_instances] at time 03:22:31.676650
2017-12-02 03:22:31,677 [salt.state       ][INFO    ][23697] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-02 03:22:31,677 [salt.state       ][INFO    ][23697] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-12-02 03:22:31,677 [salt.state       ][INFO    ][23697] Completed state [/srv/glusterfs/nova_instances] at time 03:22:31.677417 duration_in_ms=0.767
2017-12-02 03:22:31,678 [salt.state       ][INFO    ][23697] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:22:31.677581
2017-12-02 03:22:31,678 [salt.state       ][INFO    ][23697] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-02 03:22:31,678 [salt.state       ][INFO    ][23697] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-12-02 03:22:31,678 [salt.state       ][INFO    ][23697] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:22:31.678312 duration_in_ms=0.731
2017-12-02 03:22:31,679 [salt.minion      ][INFO    ][23697] Returning information for job: 20171202032150542625
2017-12-02 03:22:35,273 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command test.ping with jid 20171202032235260364
2017-12-02 03:22:35,287 [salt.minion      ][INFO    ][26495] Starting a new job with PID 26495
2017-12-02 03:22:35,313 [salt.minion      ][INFO    ][26495] Returning information for job: 20171202032235260364
2017-12-02 03:23:19,030 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command state.sls with jid 20171202032319015724
2017-12-02 03:23:19,045 [salt.minion      ][INFO    ][27133] Starting a new job with PID 27133
2017-12-02 03:23:19,487 [salt.state       ][INFO    ][27133] Loading fresh modules for state activity
2017-12-02 03:23:19,509 [salt.fileclient  ][INFO    ][27133] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-02 03:23:19,544 [salt.fileclient  ][INFO    ][27133] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-02 03:23:19,613 [salt.fileclient  ][INFO    ][27133] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-02 03:23:19,633 [salt.fileclient  ][INFO    ][27133] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-02 03:23:19,904 [salt.state       ][INFO    ][27133] Running state [attr] at time 03:23:19.904013
2017-12-02 03:23:19,904 [salt.state       ][INFO    ][27133] Executing state pkg.installed for attr
2017-12-02 03:23:19,905 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 03:23:20,208 [salt.state       ][INFO    ][27133] Package attr is already installed
2017-12-02 03:23:20,208 [salt.state       ][INFO    ][27133] Completed state [attr] at time 03:23:20.207968 duration_in_ms=303.955
2017-12-02 03:23:20,208 [salt.state       ][INFO    ][27133] Running state [glusterfs-server] at time 03:23:20.208167
2017-12-02 03:23:20,208 [salt.state       ][INFO    ][27133] Executing state pkg.installed for glusterfs-server
2017-12-02 03:23:20,211 [salt.state       ][INFO    ][27133] Package glusterfs-server is already installed
2017-12-02 03:23:20,211 [salt.state       ][INFO    ][27133] Completed state [glusterfs-server] at time 03:23:20.211035 duration_in_ms=2.867
2017-12-02 03:23:20,211 [salt.state       ][INFO    ][27133] Running state [bc] at time 03:23:20.211179
2017-12-02 03:23:20,211 [salt.state       ][INFO    ][27133] Executing state pkg.installed for bc
2017-12-02 03:23:20,214 [salt.state       ][INFO    ][27133] Package bc is already installed
2017-12-02 03:23:20,214 [salt.state       ][INFO    ][27133] Completed state [bc] at time 03:23:20.213955 duration_in_ms=2.776
2017-12-02 03:23:20,215 [salt.state       ][INFO    ][27133] Running state [glusterfs-server] at time 03:23:20.214737
2017-12-02 03:23:20,215 [salt.state       ][INFO    ][27133] Executing state service.running for glusterfs-server
2017-12-02 03:23:20,215 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-02 03:23:20,226 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-02 03:23:20,269 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-02 03:23:20,282 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-02 03:23:20,289 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-02 03:23:20,298 [salt.state       ][INFO    ][27133] The service glusterfs-server is already running
2017-12-02 03:23:20,298 [salt.state       ][INFO    ][27133] Completed state [glusterfs-server] at time 03:23:20.298328 duration_in_ms=83.589
2017-12-02 03:23:20,300 [salt.state       ][INFO    ][27133] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:23:20.299682
2017-12-02 03:23:20,300 [salt.state       ][INFO    ][27133] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-02 03:23:20,305 [salt.state       ][INFO    ][27133] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-02 03:23:20,305 [salt.state       ][INFO    ][27133] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:23:20.304722 duration_in_ms=5.04
2017-12-02 03:23:20,305 [salt.state       ][INFO    ][27133] Running state [/srv/glusterfs/glance] at time 03:23:20.304871
2017-12-02 03:23:20,305 [salt.state       ][INFO    ][27133] Executing state file.directory for /srv/glusterfs/glance
2017-12-02 03:23:20,305 [salt.state       ][INFO    ][27133] Directory /srv/glusterfs/glance is in the correct state
2017-12-02 03:23:20,305 [salt.state       ][INFO    ][27133] Completed state [/srv/glusterfs/glance] at time 03:23:20.305462 duration_in_ms=0.591
2017-12-02 03:23:20,306 [salt.state       ][INFO    ][27133] Running state [/srv/glusterfs/keystone-keys] at time 03:23:20.305617
2017-12-02 03:23:20,306 [salt.state       ][INFO    ][27133] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-02 03:23:20,306 [salt.state       ][INFO    ][27133] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-02 03:23:20,306 [salt.state       ][INFO    ][27133] Completed state [/srv/glusterfs/keystone-keys] at time 03:23:20.306213 duration_in_ms=0.596
2017-12-02 03:23:20,306 [salt.state       ][INFO    ][27133] Running state [/srv/glusterfs/nova_instances] at time 03:23:20.306353
2017-12-02 03:23:20,307 [salt.state       ][INFO    ][27133] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-02 03:23:20,307 [salt.state       ][INFO    ][27133] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-02 03:23:20,307 [salt.state       ][INFO    ][27133] Completed state [/srv/glusterfs/nova_instances] at time 03:23:20.306913 duration_in_ms=0.56
2017-12-02 03:23:20,307 [salt.state       ][INFO    ][27133] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:23:20.307051
2017-12-02 03:23:20,307 [salt.state       ][INFO    ][27133] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-02 03:23:20,308 [salt.state       ][INFO    ][27133] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-02 03:23:20,308 [salt.state       ][INFO    ][27133] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:23:20.307628 duration_in_ms=0.577
2017-12-02 03:23:20,361 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command ['git', '--version'] in directory '/root'
2017-12-02 03:23:20,449 [salt.state       ][INFO    ][27133] Running state [sleep 5] at time 03:23:20.448498
2017-12-02 03:23:20,449 [salt.state       ][INFO    ][27133] Executing state cmd.wait for sleep 5
2017-12-02 03:23:20,449 [salt.state       ][INFO    ][27133] No changes made for sleep 5
2017-12-02 03:23:20,449 [salt.state       ][INFO    ][27133] Completed state [sleep 5] at time 03:23:20.449053 duration_in_ms=0.555
2017-12-02 03:23:20,449 [salt.state       ][INFO    ][27133] Running state [10.167.4.141] at time 03:23:20.449457
2017-12-02 03:23:20,450 [salt.state       ][INFO    ][27133] Executing state glusterfs.peered for 10.167.4.141
2017-12-02 03:23:20,450 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:20,460 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:20,518 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:20,527 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:20,583 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:20,593 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:20,646 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:20,655 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:20,706 [salt.state       ][INFO    ][27133] Peering with localhost is not needed
2017-12-02 03:23:20,706 [salt.state       ][INFO    ][27133] Completed state [10.167.4.141] at time 03:23:20.706303 duration_in_ms=256.846
2017-12-02 03:23:20,709 [salt.state       ][INFO    ][27133] Running state [10.167.4.142] at time 03:23:20.708690
2017-12-02 03:23:20,709 [salt.state       ][INFO    ][27133] Executing state glusterfs.peered for 10.167.4.142
2017-12-02 03:23:20,709 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:20,719 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:20,770 [salt.state       ][INFO    ][27133] Host 10.167.4.142 already peered
2017-12-02 03:23:20,770 [salt.state       ][INFO    ][27133] Completed state [10.167.4.142] at time 03:23:20.769861 duration_in_ms=61.171
2017-12-02 03:23:20,772 [salt.state       ][INFO    ][27133] Running state [10.167.4.143] at time 03:23:20.772178
2017-12-02 03:23:20,772 [salt.state       ][INFO    ][27133] Executing state glusterfs.peered for 10.167.4.143
2017-12-02 03:23:20,773 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:20,782 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:20,833 [salt.state       ][INFO    ][27133] Host 10.167.4.143 already peered
2017-12-02 03:23:20,834 [salt.state       ][INFO    ][27133] Completed state [10.167.4.143] at time 03:23:20.833507 duration_in_ms=61.329
2017-12-02 03:23:20,834 [salt.state       ][INFO    ][27133] Running state [glance] at time 03:23:20.834428
2017-12-02 03:23:20,835 [salt.state       ][INFO    ][27133] Executing state glusterfs.created for glance
2017-12-02 03:23:20,835 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:20,844 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:20,895 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:20,905 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:20,961 [salt.state       ][INFO    ][27133] Volume glance already exists and is started.
2017-12-02 03:23:20,961 [salt.state       ][INFO    ][27133] Completed state [glance] at time 03:23:20.961422 duration_in_ms=126.994
2017-12-02 03:23:20,965 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:23:20.964589
2017-12-02 03:23:20,965 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-02 03:23:20,965 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-02 03:23:21,020 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:21,020 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:23:21.020357 duration_in_ms=55.768
2017-12-02 03:23:21,021 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:23:21.020774
2017-12-02 03:23:21,021 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-02 03:23:21,021 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-02 03:23:21,072 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:21,073 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:23:21.072730 duration_in_ms=51.954
2017-12-02 03:23:21,073 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:23:21.073213
2017-12-02 03:23:21,073 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-02 03:23:21,074 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-02 03:23:21,128 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:21,128 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:23:21.127790 duration_in_ms=54.577
2017-12-02 03:23:21,128 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 03:23:21.128220
2017-12-02 03:23:21,128 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-02 03:23:21,129 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-02 03:23:21,180 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:21,180 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 03:23:21.179954 duration_in_ms=51.734
2017-12-02 03:23:21,180 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:23:21.180432
2017-12-02 03:23:21,181 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-02 03:23:21,181 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-02 03:23:21,234 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:21,234 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:23:21.234369 duration_in_ms=53.936
2017-12-02 03:23:21,235 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:23:21.234783
2017-12-02 03:23:21,235 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-02 03:23:21,235 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-02 03:23:21,285 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:21,299 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:23:21.298472 duration_in_ms=63.688
2017-12-02 03:23:21,300 [salt.state       ][INFO    ][27133] Running state [glance] at time 03:23:21.299631
2017-12-02 03:23:21,300 [salt.state       ][INFO    ][27133] Executing state glusterfs.started for glance
2017-12-02 03:23:21,300 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:21,308 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:21,356 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:21,364 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:21,422 [salt.state       ][INFO    ][27133] Volume glance is already started
2017-12-02 03:23:21,422 [salt.state       ][INFO    ][27133] Completed state [glance] at time 03:23:21.422080 duration_in_ms=122.449
2017-12-02 03:23:21,423 [salt.state       ][INFO    ][27133] Running state [keystone-keys] at time 03:23:21.422855
2017-12-02 03:23:21,423 [salt.state       ][INFO    ][27133] Executing state glusterfs.created for keystone-keys
2017-12-02 03:23:21,423 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:21,432 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:21,484 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:21,493 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:21,549 [salt.state       ][INFO    ][27133] Volume keystone-keys already exists and is started.
2017-12-02 03:23:21,550 [salt.state       ][INFO    ][27133] Completed state [keystone-keys] at time 03:23:21.549627 duration_in_ms=126.771
2017-12-02 03:23:21,553 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:23:21.552979
2017-12-02 03:23:21,553 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-02 03:23:21,554 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-02 03:23:21,606 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:21,606 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:23:21.606132 duration_in_ms=53.153
2017-12-02 03:23:21,607 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:23:21.606578
2017-12-02 03:23:21,607 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-02 03:23:21,607 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-02 03:23:21,658 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:21,658 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:23:21.658074 duration_in_ms=51.496
2017-12-02 03:23:21,659 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 03:23:21.658551
2017-12-02 03:23:21,659 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-02 03:23:21,659 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-02 03:23:21,713 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:21,714 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 03:23:21.713655 duration_in_ms=55.104
2017-12-02 03:23:21,714 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:23:21.714095
2017-12-02 03:23:21,714 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-02 03:23:21,715 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-02 03:23:21,768 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:21,768 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:23:21.768025 duration_in_ms=53.93
2017-12-02 03:23:21,768 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:23:21.768471
2017-12-02 03:23:21,769 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-02 03:23:21,769 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-02 03:23:21,821 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:21,821 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:23:21.821430 duration_in_ms=52.958
2017-12-02 03:23:21,822 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:23:21.821887
2017-12-02 03:23:21,822 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-02 03:23:21,823 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-02 03:23:21,874 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:21,874 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:23:21.873931 duration_in_ms=52.043
2017-12-02 03:23:21,875 [salt.state       ][INFO    ][27133] Running state [keystone-keys] at time 03:23:21.874982
2017-12-02 03:23:21,875 [salt.state       ][INFO    ][27133] Executing state glusterfs.started for keystone-keys
2017-12-02 03:23:21,876 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:21,883 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:21,934 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:21,942 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:21,996 [salt.state       ][INFO    ][27133] Volume keystone-keys is already started
2017-12-02 03:23:21,997 [salt.state       ][INFO    ][27133] Completed state [keystone-keys] at time 03:23:21.996665 duration_in_ms=121.682
2017-12-02 03:23:21,998 [salt.state       ][INFO    ][27133] Running state [nova_instances] at time 03:23:21.997477
2017-12-02 03:23:21,998 [salt.state       ][INFO    ][27133] Executing state glusterfs.created for nova_instances
2017-12-02 03:23:21,998 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:22,007 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:22,057 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:22,065 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:22,119 [salt.state       ][INFO    ][27133] Volume nova_instances already exists and is started.
2017-12-02 03:23:22,120 [salt.state       ][INFO    ][27133] Completed state [nova_instances] at time 03:23:22.119614 duration_in_ms=122.137
2017-12-02 03:23:22,124 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:23:22.124333
2017-12-02 03:23:22,125 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-02 03:23:22,126 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-02 03:23:22,177 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:22,177 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:23:22.176941 duration_in_ms=52.61
2017-12-02 03:23:22,177 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 03:23:22.177373
2017-12-02 03:23:22,178 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-02 03:23:22,178 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-02 03:23:22,230 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:22,230 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 03:23:22.229862 duration_in_ms=52.489
2017-12-02 03:23:22,230 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 03:23:22.230282
2017-12-02 03:23:22,231 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-02 03:23:22,231 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-02 03:23:22,281 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:22,281 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 03:23:22.281241 duration_in_ms=50.958
2017-12-02 03:23:22,282 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 03:23:22.281695
2017-12-02 03:23:22,282 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-02 03:23:22,282 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-02 03:23:22,332 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:22,332 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 03:23:22.332135 duration_in_ms=50.44
2017-12-02 03:23:22,333 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 03:23:22.332607
2017-12-02 03:23:22,333 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-02 03:23:22,333 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-02 03:23:22,396 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:22,396 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 03:23:22.396311 duration_in_ms=63.703
2017-12-02 03:23:22,397 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:23:22.396856
2017-12-02 03:23:22,397 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-02 03:23:22,398 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-02 03:23:22,450 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:22,451 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:23:22.450467 duration_in_ms=53.611
2017-12-02 03:23:22,452 [salt.state       ][INFO    ][27133] Running state [nova_instances] at time 03:23:22.451562
2017-12-02 03:23:22,452 [salt.state       ][INFO    ][27133] Executing state glusterfs.started for nova_instances
2017-12-02 03:23:22,452 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:22,460 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:22,512 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:22,521 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:22,576 [salt.state       ][INFO    ][27133] Volume nova_instances is already started
2017-12-02 03:23:22,576 [salt.state       ][INFO    ][27133] Completed state [nova_instances] at time 03:23:22.576293 duration_in_ms=124.73
2017-12-02 03:23:22,577 [salt.state       ][INFO    ][27133] Running state [keystone-credential-keys] at time 03:23:22.577194
2017-12-02 03:23:22,577 [salt.state       ][INFO    ][27133] Executing state glusterfs.created for keystone-credential-keys
2017-12-02 03:23:22,578 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:22,586 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:22,634 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:22,643 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:22,699 [salt.state       ][INFO    ][27133] Volume keystone-credential-keys already exists and is started.
2017-12-02 03:23:22,699 [salt.state       ][INFO    ][27133] Completed state [keystone-credential-keys] at time 03:23:22.698796 duration_in_ms=121.601
2017-12-02 03:23:22,703 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:23:22.702684
2017-12-02 03:23:22,703 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-02 03:23:22,703 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-02 03:23:22,753 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:22,754 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:23:22.753675 duration_in_ms=50.99
2017-12-02 03:23:22,754 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 03:23:22.754101
2017-12-02 03:23:22,754 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-02 03:23:22,755 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-02 03:23:22,804 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:22,804 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 03:23:22.803743 duration_in_ms=49.642
2017-12-02 03:23:22,804 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:23:22.804334
2017-12-02 03:23:22,805 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-02 03:23:22,805 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-02 03:23:22,855 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:22,856 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:23:22.855558 duration_in_ms=51.224
2017-12-02 03:23:22,856 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:23:22.856002
2017-12-02 03:23:22,856 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-02 03:23:22,857 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-02 03:23:22,905 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:22,906 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:23:22.905468 duration_in_ms=49.466
2017-12-02 03:23:22,906 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:23:22.905952
2017-12-02 03:23:22,906 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-02 03:23:22,907 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-02 03:23:22,957 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:22,957 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:23:22.957006 duration_in_ms=51.053
2017-12-02 03:23:22,958 [salt.state       ][INFO    ][27133] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:23:22.957489
2017-12-02 03:23:22,958 [salt.state       ][INFO    ][27133] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-02 03:23:22,958 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-02 03:23:23,011 [salt.state       ][INFO    ][27133] unless execution succeeded
2017-12-02 03:23:23,011 [salt.state       ][INFO    ][27133] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:23:23.010910 duration_in_ms=53.421
2017-12-02 03:23:23,012 [salt.state       ][INFO    ][27133] Running state [keystone-credential-keys] at time 03:23:23.011950
2017-12-02 03:23:23,012 [salt.state       ][INFO    ][27133] Executing state glusterfs.started for keystone-credential-keys
2017-12-02 03:23:23,013 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:23,020 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:23,071 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --version' in directory '/root'
2017-12-02 03:23:23,079 [salt.loaded.int.module.cmdmod][INFO    ][27133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 03:23:23,134 [salt.state       ][INFO    ][27133] Volume keystone-credential-keys is already started
2017-12-02 03:23:23,134 [salt.state       ][INFO    ][27133] Completed state [keystone-credential-keys] at time 03:23:23.134149 duration_in_ms=122.198
2017-12-02 03:23:23,137 [salt.minion      ][INFO    ][27133] Returning information for job: 20171202032319015724
2017-12-02 03:23:24,312 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command test.ping with jid 20171202032324298461
2017-12-02 03:23:24,326 [salt.minion      ][INFO    ][27661] Starting a new job with PID 27661
2017-12-02 03:23:24,351 [salt.minion      ][INFO    ][27661] Returning information for job: 20171202032324298461
2017-12-02 03:23:25,010 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command cmd.run with jid 20171202032324996189
2017-12-02 03:23:25,026 [salt.minion      ][INFO    ][27666] Starting a new job with PID 27666
2017-12-02 03:23:25,029 [salt.loaded.int.module.cmdmod][INFO    ][27666] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-02 03:23:25,147 [salt.minion      ][INFO    ][27666] Returning information for job: 20171202032324996189
2017-12-02 04:00:04,477 [salt.utils.schedule][INFO    ][21718] Running scheduled job: __mine_interval
2017-12-02 04:55:23,272 [salt.minion      ][INFO    ][21718] User sudo_ubuntu Executing command cp.push_dir with jid 20171202045523260463
2017-12-02 04:55:23,294 [salt.minion      ][INFO    ][28779] Starting a new job with PID 28779
