2017-11-03 04:35:10,809 [salt.cli.daemons ][WARNING ][2496] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-03 04:35:26,553 [salt.state       ][ERROR   ][3746] No contents found in top file
2017-11-03 04:37:15,894 [salt.utils.parsers][WARNING ][2496] Minion received a SIGTERM. Exiting.
2017-11-03 04:39:29,708 [salt.cli.daemons ][WARNING ][3429] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-03 04:42:31,694 [salt.loaded.int.module.cmdmod][ERROR   ][11372] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-11-03 04:42:31,694 [salt.loaded.int.module.cmdmod][ERROR   ][11372] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-11-03 04:42:31,694 [salt.loaded.int.module.cmdmod][ERROR   ][11372] retcode: 1
2017-11-03 04:42:31,695 [salt.state       ][ERROR   ][11372] {'pid': 16278, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-11-03 04:42:47,963 [py.warnings      ][WARNING ][16359] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-03 04:43:52,065 [salt.loaded.int.module.cmdmod][ERROR   ][16359] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-03 04:43:52,065 [salt.loaded.int.module.cmdmod][ERROR   ][16359] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-03 04:43:58,667 [salt.loaded.int.module.cmdmod][ERROR   ][16359] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-03 04:43:58,668 [salt.loaded.int.module.cmdmod][ERROR   ][16359] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-03 04:44:07,663 [salt.loaded.int.module.cmdmod][ERROR   ][16359] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-03 04:44:07,664 [salt.loaded.int.module.cmdmod][ERROR   ][16359] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-03 04:44:20,127 [salt.loaded.int.module.cmdmod][ERROR   ][16359] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-03 04:44:20,127 [salt.loaded.int.module.cmdmod][ERROR   ][16359] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-03 04:44:28,764 [salt.loaded.int.module.cmdmod][ERROR   ][16359] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-03 04:44:28,764 [salt.loaded.int.module.cmdmod][ERROR   ][16359] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-03 04:44:39,009 [salt.loaded.int.module.cmdmod][ERROR   ][16359] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-03 04:44:39,010 [salt.loaded.int.module.cmdmod][ERROR   ][16359] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-03 04:44:46,878 [salt.loaded.int.module.cmdmod][ERROR   ][16359] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-11-03 04:44:50,358 [salt.state       ][ERROR   ][24336] No contents found in top file
2017-11-03 04:44:54,434 [salt.loaded.int.module.cmdmod][INFO    ][24705] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-03 04:44:54,442 [salt.loaded.int.module.cmdmod][INFO    ][24705] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-03 04:44:54,453 [salt.loaded.int.module.cmdmod][INFO    ][24705] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-03 04:44:54,461 [salt.utils.parsers][WARNING ][3429] Minion received a SIGTERM. Exiting.
2017-11-03 04:44:54,727 [salt.cli.daemons ][INFO    ][24813] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-odl-ha.local"
2017-11-03 04:44:55,247 [salt.minion      ][INFO    ][24813] Creating minion process manager
2017-11-03 04:44:55,247 [salt.cli.daemons ][WARNING ][24813] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-03 04:44:55,247 [salt.cli.daemons ][INFO    ][24813] The Salt Minion is starting up
2017-11-03 04:44:55,248 [salt.minion      ][INFO    ][24813] Minion is starting as user 'root'
2017-11-03 04:44:55,248 [salt.utils.event ][INFO    ][24813] Starting pull socket on /var/run/salt/minion/minion_event_2d6d7b82d1_pull.ipc
2017-11-03 04:44:56,172 [salt.loaded.int.module.cmdmod][INFO    ][24813] Executing command ['date', '+%z'] in directory '/root'
2017-11-03 04:44:56,181 [salt.utils.schedule][INFO    ][24813] Updating job settings for scheduled job: __mine_interval
2017-11-03 04:44:56,183 [salt.minion      ][INFO    ][24813] Added mine.update to scheduler
2017-11-03 04:44:56,323 [salt.minion      ][INFO    ][24813] Minion is ready to receive requests!
2017-11-03 04:44:57,324 [salt.utils.schedule][INFO    ][24813] Running scheduled job: __mine_interval
2017-11-03 04:44:58,319 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command state.sls with jid 20171103044458314621
2017-11-03 04:44:58,332 [salt.minion      ][INFO    ][24939] Starting a new job with PID 24939
2017-11-03 04:44:58,779 [salt.state       ][INFO    ][24939] Loading fresh modules for state activity
2017-11-03 04:44:58,803 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-03 04:44:58,821 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-03 04:44:58,845 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-03 04:44:58,972 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-03 04:44:58,987 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-03 04:44:59,039 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-03 04:44:59,103 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-03 04:44:59,122 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-03 04:44:59,163 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-03 04:44:59,200 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-03 04:44:59,213 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-03 04:44:59,230 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-03 04:44:59,238 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-03 04:44:59,300 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-03 04:44:59,316 [py.warnings      ][WARNING ][24939] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-03 04:44:59,316 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'salt-minion --version' in directory '/root'
2017-11-03 04:44:59,580 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-03 04:44:59,601 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-03 04:44:59,639 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-03 04:44:59,653 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-03 04:44:59,700 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-03 04:44:59,769 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-03 04:44:59,828 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-03 04:44:59,862 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-03 04:44:59,925 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-03 04:44:59,941 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-03 04:44:59,984 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-03 04:45:00,000 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-03 04:45:00,012 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-03 04:45:00,026 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-03 04:45:00,032 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-03 04:45:00,105 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-03 04:45:00,123 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'salt-minion --version' in directory '/root'
2017-11-03 04:45:00,374 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-03 04:45:00,412 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-03 04:45:00,422 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-03 04:45:00,459 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-03 04:45:00,501 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-03 04:45:00,546 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-03 04:45:00,615 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-03 04:45:00,684 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-03 04:45:01,117 [salt.state       ][INFO    ][24939] Running state [salt-minion] at time 04:45:01.116450
2017-11-03 04:45:01,117 [salt.state       ][INFO    ][24939] Executing state pkg.installed for salt-minion
2017-11-03 04:45:01,117 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-03 04:45:01,364 [salt.state       ][INFO    ][24939] Package salt-minion is already installed
2017-11-03 04:45:01,364 [salt.state       ][INFO    ][24939] Completed state [salt-minion] at time 04:45:01.363835 duration_in_ms=247.385
2017-11-03 04:45:01,364 [salt.state       ][INFO    ][24939] Running state [salt_minion_dependency_packages] at time 04:45:01.364076
2017-11-03 04:45:01,364 [salt.state       ][INFO    ][24939] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-03 04:45:01,367 [salt.state       ][INFO    ][24939] All specified packages are already installed
2017-11-03 04:45:01,367 [salt.state       ][INFO    ][24939] Completed state [salt_minion_dependency_packages] at time 04:45:01.367067 duration_in_ms=2.99
2017-11-03 04:45:01,369 [salt.state       ][INFO    ][24939] Running state [/etc/salt/minion.d/minion.conf] at time 04:45:01.368534
2017-11-03 04:45:01,369 [salt.state       ][INFO    ][24939] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-03 04:45:01,389 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-03 04:45:01,448 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-03 04:45:01,495 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-03 04:45:01,530 [salt.state       ][INFO    ][24939] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-03 04:45:01,530 [salt.state       ][INFO    ][24939] Completed state [/etc/salt/minion.d/minion.conf] at time 04:45:01.530274 duration_in_ms=161.74
2017-11-03 04:45:01,531 [salt.state       ][INFO    ][24939] Running state [/etc/salt/minion.d/_virt.conf] at time 04:45:01.530622
2017-11-03 04:45:01,531 [salt.state       ][INFO    ][24939] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-03 04:45:01,544 [salt.state       ][INFO    ][24939] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-03 04:45:01,544 [salt.state       ][INFO    ][24939] Completed state [/etc/salt/minion.d/_virt.conf] at time 04:45:01.543742 duration_in_ms=13.121
2017-11-03 04:45:01,545 [salt.state       ][INFO    ][24939] Running state [salt-minion] at time 04:45:01.545249
2017-11-03 04:45:01,545 [salt.state       ][INFO    ][24939] Executing state service.running for salt-minion
2017-11-03 04:45:01,546 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-03 04:45:01,562 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-03 04:45:01,570 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-03 04:45:01,578 [salt.state       ][INFO    ][24939] The service salt-minion is already running
2017-11-03 04:45:01,578 [salt.state       ][INFO    ][24939] Completed state [salt-minion] at time 04:45:01.577762 duration_in_ms=32.513
2017-11-03 04:45:01,579 [salt.state       ][INFO    ][24939] Running state [/etc/salt/grains.d] at time 04:45:01.579066
2017-11-03 04:45:01,579 [salt.state       ][INFO    ][24939] Executing state file.directory for /etc/salt/grains.d
2017-11-03 04:45:01,580 [salt.state       ][INFO    ][24939] Directory /etc/salt/grains.d is in the correct state
2017-11-03 04:45:01,580 [salt.state       ][INFO    ][24939] Completed state [/etc/salt/grains.d] at time 04:45:01.579946 duration_in_ms=0.88
2017-11-03 04:45:01,580 [salt.state       ][INFO    ][24939] Running state [/etc/salt/grains] at time 04:45:01.580368
2017-11-03 04:45:01,581 [salt.state       ][INFO    ][24939] Executing state file.managed for /etc/salt/grains
2017-11-03 04:45:01,581 [salt.state       ][INFO    ][24939] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-03 04:45:01,581 [salt.state       ][INFO    ][24939] Completed state [/etc/salt/grains] at time 04:45:01.580998 duration_in_ms=0.63
2017-11-03 04:45:01,581 [salt.state       ][INFO    ][24939] Running state [/etc/salt/grains.d/placeholder] at time 04:45:01.581264
2017-11-03 04:45:01,581 [salt.state       ][INFO    ][24939] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-03 04:45:01,582 [salt.state       ][INFO    ][24939] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-03 04:45:01,582 [salt.state       ][INFO    ][24939] Completed state [/etc/salt/grains.d/placeholder] at time 04:45:01.581897 duration_in_ms=0.633
2017-11-03 04:45:01,582 [salt.state       ][INFO    ][24939] Running state [/etc/salt/grains.d/sphinx] at time 04:45:01.582192
2017-11-03 04:45:01,582 [salt.state       ][INFO    ][24939] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-03 04:45:01,613 [salt.state       ][INFO    ][24939] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.143
               - 127.0.0.1
               - 192.168.11.253
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-03 04:45:01,613 [salt.state       ][INFO    ][24939] Completed state [/etc/salt/grains.d/sphinx] at time 04:45:01.613291 duration_in_ms=31.099
2017-11-03 04:45:01,614 [salt.state       ][INFO    ][24939] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 04:45:01.613924
2017-11-03 04:45:01,614 [salt.state       ][INFO    ][24939] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-03 04:45:01,614 [salt.state       ][INFO    ][24939] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-03 04:45:01,615 [salt.state       ][INFO    ][24939] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 04:45:01.614533 duration_in_ms=0.608
2017-11-03 04:45:01,615 [salt.state       ][INFO    ][24939] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 04:45:01.614683
2017-11-03 04:45:01,615 [salt.state       ][INFO    ][24939] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-03 04:45:01,615 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-03 04:45:01,708 [salt.state       ][INFO    ][24939] {'pid': 24996, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-03 04:45:01,708 [salt.state       ][INFO    ][24939] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 04:45:01.708049 duration_in_ms=93.366
2017-11-03 04:45:01,709 [salt.state       ][INFO    ][24939] Running state [/etc/salt/grains.d/dns_records] at time 04:45:01.708526
2017-11-03 04:45:01,709 [salt.state       ][INFO    ][24939] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-03 04:45:01,755 [salt.state       ][INFO    ][24939] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-03 04:45:01,755 [salt.state       ][INFO    ][24939] Completed state [/etc/salt/grains.d/dns_records] at time 04:45:01.754770 duration_in_ms=46.244
2017-11-03 04:45:01,756 [salt.state       ][INFO    ][24939] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 04:45:01.755470
2017-11-03 04:45:01,756 [salt.state       ][INFO    ][24939] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-03 04:45:01,756 [salt.state       ][INFO    ][24939] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-03 04:45:01,756 [salt.state       ][INFO    ][24939] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 04:45:01.756148 duration_in_ms=0.678
2017-11-03 04:45:01,757 [salt.state       ][INFO    ][24939] Running state [/etc/salt/grains.d/salt] at time 04:45:01.756495
2017-11-03 04:45:01,757 [salt.state       ][INFO    ][24939] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-03 04:45:01,798 [salt.state       ][INFO    ][24939] File /etc/salt/grains.d/salt is in the correct state
2017-11-03 04:45:01,798 [salt.state       ][INFO    ][24939] Completed state [/etc/salt/grains.d/salt] at time 04:45:01.798071 duration_in_ms=41.575
2017-11-03 04:45:01,799 [salt.state       ][INFO    ][24939] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 04:45:01.798706
2017-11-03 04:45:01,799 [salt.state       ][INFO    ][24939] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-03 04:45:01,799 [salt.state       ][INFO    ][24939] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-03 04:45:01,799 [salt.state       ][INFO    ][24939] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 04:45:01.799325 duration_in_ms=0.619
2017-11-03 04:45:01,801 [salt.state       ][INFO    ][24939] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 04:45:01.800582
2017-11-03 04:45:01,801 [salt.state       ][INFO    ][24939] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-03 04:45:01,801 [salt.state       ][INFO    ][24939] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-03 04:45:01,801 [salt.state       ][INFO    ][24939] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 04:45:01.801202 duration_in_ms=0.62
2017-11-03 04:45:01,801 [salt.state       ][INFO    ][24939] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 04:45:01.801359
2017-11-03 04:45:01,802 [salt.state       ][INFO    ][24939] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-03 04:45:01,803 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-03 04:45:01,811 [salt.state       ][INFO    ][24939] {'pid': 24998, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-03 04:45:01,812 [salt.state       ][INFO    ][24939] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 04:45:01.811706 duration_in_ms=10.347
2017-11-03 04:45:01,812 [salt.state       ][INFO    ][24939] Running state [mine.update] at time 04:45:01.812336
2017-11-03 04:45:01,813 [salt.state       ][INFO    ][24939] Executing state module.wait for mine.update
2017-11-03 04:45:01,813 [salt.state       ][INFO    ][24939] No changes made for mine.update
2017-11-03 04:45:01,813 [salt.state       ][INFO    ][24939] Completed state [mine.update] at time 04:45:01.812914 duration_in_ms=0.578
2017-11-03 04:45:01,813 [salt.state       ][INFO    ][24939] Running state [mine.update] at time 04:45:01.813053
2017-11-03 04:45:01,813 [salt.state       ][INFO    ][24939] Executing state module.mod_watch for mine.update
2017-11-03 04:45:02,333 [salt.state       ][INFO    ][24939] {'ret': True}
2017-11-03 04:45:02,334 [salt.state       ][INFO    ][24939] Completed state [mine.update] at time 04:45:02.333695 duration_in_ms=520.641
2017-11-03 04:45:02,334 [salt.state       ][INFO    ][24939] Running state [ca-certificates] at time 04:45:02.333959
2017-11-03 04:45:02,334 [salt.state       ][INFO    ][24939] Executing state pkg.installed for ca-certificates
2017-11-03 04:45:02,338 [salt.state       ][INFO    ][24939] Package ca-certificates is already installed
2017-11-03 04:45:02,338 [salt.state       ][INFO    ][24939] Completed state [ca-certificates] at time 04:45:02.337661 duration_in_ms=3.702
2017-11-03 04:45:02,338 [salt.state       ][INFO    ][24939] Running state [update-ca-certificates] at time 04:45:02.338259
2017-11-03 04:45:02,339 [salt.state       ][INFO    ][24939] Executing state cmd.wait for update-ca-certificates
2017-11-03 04:45:02,339 [salt.state       ][INFO    ][24939] No changes made for update-ca-certificates
2017-11-03 04:45:02,339 [salt.state       ][INFO    ][24939] Completed state [update-ca-certificates] at time 04:45:02.338896 duration_in_ms=0.637
2017-11-03 04:45:02,339 [salt.state       ][INFO    ][24939] Running state [libvirt-dev] at time 04:45:02.339082
2017-11-03 04:45:02,339 [salt.state       ][INFO    ][24939] Executing state pkg.installed for libvirt-dev
2017-11-03 04:45:02,342 [salt.state       ][INFO    ][24939] Package libvirt-dev is already installed
2017-11-03 04:45:02,342 [salt.state       ][INFO    ][24939] Completed state [libvirt-dev] at time 04:45:02.342157 duration_in_ms=3.075
2017-11-03 04:45:02,342 [salt.state       ][INFO    ][24939] Running state [pkg-config] at time 04:45:02.342342
2017-11-03 04:45:02,343 [salt.state       ][INFO    ][24939] Executing state pkg.installed for pkg-config
2017-11-03 04:45:02,345 [salt.state       ][INFO    ][24939] Package pkg-config is already installed
2017-11-03 04:45:02,345 [salt.state       ][INFO    ][24939] Completed state [pkg-config] at time 04:45:02.345386 duration_in_ms=3.043
2017-11-03 04:45:02,346 [salt.state       ][INFO    ][24939] Running state [virtng.init] at time 04:45:02.345575
2017-11-03 04:45:02,346 [salt.state       ][INFO    ][24939] Executing state module.run for virtng.init
2017-11-03 04:45:02,402 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command ['git', '--version'] in directory '/root'
2017-11-03 04:45:02,536 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-03 04:45:02,555 [salt.state       ][INFO    ][24939] unless execution succeeded
2017-11-03 04:45:02,573 [salt.state       ][INFO    ][24939] Completed state [virtng.init] at time 04:45:02.572794 duration_in_ms=227.218
2017-11-03 04:45:02,573 [salt.state       ][INFO    ][24939] Running state [virt.set_autostart] at time 04:45:02.573094
2017-11-03 04:45:02,573 [salt.state       ][INFO    ][24939] Executing state module.run for virt.set_autostart
2017-11-03 04:45:02,575 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-03 04:45:02,592 [salt.state       ][INFO    ][24939] unless execution succeeded
2017-11-03 04:45:02,592 [salt.state       ][INFO    ][24939] Completed state [virt.set_autostart] at time 04:45:02.592111 duration_in_ms=19.017
2017-11-03 04:45:02,592 [salt.state       ][INFO    ][24939] Running state [virtng.init] at time 04:45:02.592330
2017-11-03 04:45:02,593 [salt.state       ][INFO    ][24939] Executing state module.run for virtng.init
2017-11-03 04:45:02,594 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-03 04:45:02,609 [salt.state       ][INFO    ][24939] unless execution succeeded
2017-11-03 04:45:02,610 [salt.state       ][INFO    ][24939] Completed state [virtng.init] at time 04:45:02.609587 duration_in_ms=17.257
2017-11-03 04:45:02,610 [salt.state       ][INFO    ][24939] Running state [virt.set_autostart] at time 04:45:02.609812
2017-11-03 04:45:02,610 [salt.state       ][INFO    ][24939] Executing state module.run for virt.set_autostart
2017-11-03 04:45:02,612 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-03 04:45:02,628 [salt.state       ][INFO    ][24939] unless execution succeeded
2017-11-03 04:45:02,628 [salt.state       ][INFO    ][24939] Completed state [virt.set_autostart] at time 04:45:02.627714 duration_in_ms=17.902
2017-11-03 04:45:02,628 [salt.state       ][INFO    ][24939] Running state [virtng.init] at time 04:45:02.627946
2017-11-03 04:45:02,628 [salt.state       ][INFO    ][24939] Executing state module.run for virtng.init
2017-11-03 04:45:02,630 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-03 04:45:02,644 [salt.state       ][INFO    ][24939] unless execution succeeded
2017-11-03 04:45:02,645 [salt.state       ][INFO    ][24939] Completed state [virtng.init] at time 04:45:02.644521 duration_in_ms=16.575
2017-11-03 04:45:02,645 [salt.state       ][INFO    ][24939] Running state [virt.set_autostart] at time 04:45:02.644745
2017-11-03 04:45:02,645 [salt.state       ][INFO    ][24939] Executing state module.run for virt.set_autostart
2017-11-03 04:45:02,647 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-03 04:45:02,661 [salt.state       ][INFO    ][24939] unless execution succeeded
2017-11-03 04:45:02,661 [salt.state       ][INFO    ][24939] Completed state [virt.set_autostart] at time 04:45:02.661288 duration_in_ms=16.541
2017-11-03 04:45:02,662 [salt.state       ][INFO    ][24939] Running state [virtng.init] at time 04:45:02.661510
2017-11-03 04:45:02,662 [salt.state       ][INFO    ][24939] Executing state module.run for virtng.init
2017-11-03 04:45:02,664 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'virsh list --all --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-03 04:45:02,678 [salt.state       ][INFO    ][24939] unless execution succeeded
2017-11-03 04:45:02,679 [salt.state       ][INFO    ][24939] Completed state [virtng.init] at time 04:45:02.678498 duration_in_ms=16.988
2017-11-03 04:45:02,679 [salt.state       ][INFO    ][24939] Running state [virt.set_autostart] at time 04:45:02.678708
2017-11-03 04:45:02,679 [salt.state       ][INFO    ][24939] Executing state module.run for virt.set_autostart
2017-11-03 04:45:02,681 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'virsh list --autostart --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-03 04:45:02,696 [salt.state       ][INFO    ][24939] unless execution succeeded
2017-11-03 04:45:02,705 [salt.state       ][INFO    ][24939] Completed state [virt.set_autostart] at time 04:45:02.704879 duration_in_ms=26.169
2017-11-03 04:45:02,705 [salt.state       ][INFO    ][24939] Running state [virtng.init] at time 04:45:02.705202
2017-11-03 04:45:02,705 [salt.state       ][INFO    ][24939] Executing state module.run for virtng.init
2017-11-03 04:45:02,707 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-03 04:45:02,721 [salt.state       ][INFO    ][24939] unless execution succeeded
2017-11-03 04:45:02,721 [salt.state       ][INFO    ][24939] Completed state [virtng.init] at time 04:45:02.721131 duration_in_ms=15.929
2017-11-03 04:45:02,721 [salt.state       ][INFO    ][24939] Running state [virt.set_autostart] at time 04:45:02.721339
2017-11-03 04:45:02,722 [salt.state       ][INFO    ][24939] Executing state module.run for virt.set_autostart
2017-11-03 04:45:02,723 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-03 04:45:02,737 [salt.state       ][INFO    ][24939] unless execution succeeded
2017-11-03 04:45:02,737 [salt.state       ][INFO    ][24939] Completed state [virt.set_autostart] at time 04:45:02.736908 duration_in_ms=15.569
2017-11-03 04:45:02,737 [salt.state       ][INFO    ][24939] Running state [virtng.init] at time 04:45:02.737120
2017-11-03 04:45:02,737 [salt.state       ][INFO    ][24939] Executing state module.run for virtng.init
2017-11-03 04:45:02,739 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-03 04:45:02,753 [salt.state       ][INFO    ][24939] unless execution succeeded
2017-11-03 04:45:02,753 [salt.state       ][INFO    ][24939] Completed state [virtng.init] at time 04:45:02.752818 duration_in_ms=15.697
2017-11-03 04:45:02,753 [salt.state       ][INFO    ][24939] Running state [virt.set_autostart] at time 04:45:02.753031
2017-11-03 04:45:02,753 [salt.state       ][INFO    ][24939] Executing state module.run for virt.set_autostart
2017-11-03 04:45:02,755 [salt.loaded.int.module.cmdmod][INFO    ][24939] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-03 04:45:02,768 [salt.state       ][INFO    ][24939] unless execution succeeded
2017-11-03 04:45:02,777 [salt.state       ][INFO    ][24939] Completed state [virt.set_autostart] at time 04:45:02.776913 duration_in_ms=23.882
2017-11-03 04:45:02,779 [salt.minion      ][INFO    ][24939] Returning information for job: 20171103044458314621
2017-11-03 04:46:26,306 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171103044626302009
2017-11-03 04:46:26,323 [salt.minion      ][INFO    ][25071] Starting a new job with PID 25071
2017-11-03 04:46:28,970 [salt.state       ][INFO    ][25071] Loading fresh modules for state activity
2017-11-03 04:46:28,988 [salt.state       ][ERROR   ][25071] No contents found in top file
2017-11-03 04:46:28,989 [salt.utils.extmods][INFO    ][25071] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-03 04:46:28,992 [salt.utils.extmods][INFO    ][25071] Syncing beacons for environment 'base'
2017-11-03 04:46:28,992 [salt.utils.extmods][INFO    ][25071] Loading cache from salt://_beacons, for base)
2017-11-03 04:46:28,992 [salt.fileclient  ][INFO    ][25071] Caching directory '_beacons/' for environment 'base'
2017-11-03 04:46:29,011 [salt.utils.extmods][INFO    ][25071] Syncing modules for environment 'base'
2017-11-03 04:46:29,012 [salt.utils.extmods][INFO    ][25071] Loading cache from salt://_modules, for base)
2017-11-03 04:46:29,012 [salt.fileclient  ][INFO    ][25071] Caching directory '_modules/' for environment 'base'
2017-11-03 04:46:29,037 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-03 04:46:29,044 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-03 04:46:29,054 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-03 04:46:29,062 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-03 04:46:29,069 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-03 04:46:29,077 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-03 04:46:29,087 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-03 04:46:29,272 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-03 04:46:29,291 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-03 04:46:29,322 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-03 04:46:29,355 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-03 04:46:29,402 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-03 04:46:29,411 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-03 04:46:29,422 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-03 04:46:29,433 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-03 04:46:29,476 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-03 04:46:29,528 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-03 04:46:29,546 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-03 04:46:29,570 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-03 04:46:29,615 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-03 04:46:29,636 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-03 04:46:29,658 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-03 04:46:29,667 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-03 04:46:29,715 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-03 04:46:29,723 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-03 04:46:29,746 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-03 04:46:29,777 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-03 04:46:29,812 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-03 04:46:29,844 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-03 04:46:29,880 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-03 04:46:29,888 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-03 04:46:29,896 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-03 04:46:29,909 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-03 04:46:29,912 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-03 04:46:29,912 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-03 04:46:29,912 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-03 04:46:29,913 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-03 04:46:29,913 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-03 04:46:29,913 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-03 04:46:29,914 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-03 04:46:29,914 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-03 04:46:29,914 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-03 04:46:29,914 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-03 04:46:29,915 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-03 04:46:29,915 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-03 04:46:29,915 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-03 04:46:29,915 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-03 04:46:29,916 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-03 04:46:29,916 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-03 04:46:29,916 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-03 04:46:29,916 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-03 04:46:29,917 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-03 04:46:29,917 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-03 04:46:29,917 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-03 04:46:29,917 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-03 04:46:29,918 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-03 04:46:29,918 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-03 04:46:29,918 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-03 04:46:29,919 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-03 04:46:29,919 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-03 04:46:29,919 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-03 04:46:29,919 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-03 04:46:29,920 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-03 04:46:29,920 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-03 04:46:29,920 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-03 04:46:29,920 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-11-03 04:46:29,921 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-03 04:46:29,921 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-03 04:46:29,925 [salt.utils.extmods][INFO    ][25071] Syncing states for environment 'base'
2017-11-03 04:46:29,925 [salt.utils.extmods][INFO    ][25071] Loading cache from salt://_states, for base)
2017-11-03 04:46:29,925 [salt.fileclient  ][INFO    ][25071] Caching directory '_states/' for environment 'base'
2017-11-03 04:46:29,969 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-03 04:46:30,002 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-03 04:46:30,069 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-03 04:46:30,081 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-03 04:46:30,091 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-03 04:46:30,098 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-03 04:46:30,114 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-03 04:46:30,122 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-03 04:46:30,151 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-03 04:46:30,166 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-03 04:46:30,175 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-03 04:46:30,184 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-03 04:46:30,217 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-03 04:46:30,232 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-03 04:46:30,240 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-03 04:46:30,257 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-03 04:46:30,266 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-03 04:46:30,308 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-03 04:46:30,324 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-03 04:46:30,351 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-03 04:46:30,373 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-03 04:46:30,419 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-03 04:46:30,431 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-03 04:46:30,471 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-03 04:46:30,526 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-03 04:46:30,533 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-03 04:46:30,540 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-03 04:46:30,548 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-03 04:46:30,575 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-03 04:46:30,577 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-03 04:46:30,577 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-03 04:46:30,578 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-03 04:46:30,578 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-03 04:46:30,578 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-03 04:46:30,578 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-03 04:46:30,579 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-03 04:46:30,579 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-03 04:46:30,579 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-03 04:46:30,579 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-03 04:46:30,579 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-03 04:46:30,579 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-03 04:46:30,580 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-03 04:46:30,580 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-03 04:46:30,580 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-03 04:46:30,580 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-03 04:46:30,580 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-03 04:46:30,581 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-03 04:46:30,581 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-03 04:46:30,581 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-03 04:46:30,581 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-03 04:46:30,581 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-03 04:46:30,581 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-03 04:46:30,582 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-03 04:46:30,582 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-03 04:46:30,582 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-03 04:46:30,582 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-03 04:46:30,582 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-03 04:46:30,583 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-03 04:46:30,583 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-03 04:46:30,585 [salt.utils.extmods][INFO    ][25071] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-03 04:46:30,588 [salt.utils.extmods][INFO    ][25071] Syncing sdb for environment 'base'
2017-11-03 04:46:30,588 [salt.utils.extmods][INFO    ][25071] Loading cache from salt://_sdb, for base)
2017-11-03 04:46:30,588 [salt.fileclient  ][INFO    ][25071] Caching directory '_sdb/' for environment 'base'
2017-11-03 04:46:30,624 [salt.utils.extmods][INFO    ][25071] Syncing grains for environment 'base'
2017-11-03 04:46:30,624 [salt.utils.extmods][INFO    ][25071] Loading cache from salt://_grains, for base)
2017-11-03 04:46:30,624 [salt.fileclient  ][INFO    ][25071] Caching directory '_grains/' for environment 'base'
2017-11-03 04:46:30,667 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-03 04:46:30,680 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-03 04:46:30,693 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-03 04:46:30,761 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-03 04:46:30,773 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-03 04:46:30,784 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-03 04:46:30,875 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-03 04:46:30,897 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-03 04:46:30,971 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-03 04:46:30,987 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-03 04:46:31,000 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-03 04:46:31,007 [salt.fileclient  ][INFO    ][25071] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-03 04:46:31,010 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-03 04:46:31,010 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-03 04:46:31,010 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-03 04:46:31,011 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-03 04:46:31,011 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-03 04:46:31,011 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-03 04:46:31,012 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-03 04:46:31,012 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-03 04:46:31,012 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-03 04:46:31,013 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-03 04:46:31,013 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-03 04:46:31,013 [salt.utils.extmods][INFO    ][25071] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-03 04:46:31,014 [salt.utils.extmods][INFO    ][25071] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-03 04:46:31,017 [salt.utils.extmods][INFO    ][25071] Syncing renderers for environment 'base'
2017-11-03 04:46:31,017 [salt.utils.extmods][INFO    ][25071] Loading cache from salt://_renderers, for base)
2017-11-03 04:46:31,017 [salt.fileclient  ][INFO    ][25071] Caching directory '_renderers/' for environment 'base'
2017-11-03 04:46:31,305 [salt.utils.extmods][INFO    ][25071] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-03 04:46:31,307 [salt.utils.extmods][INFO    ][25071] Syncing returners for environment 'base'
2017-11-03 04:46:31,307 [salt.utils.extmods][INFO    ][25071] Loading cache from salt://_returners, for base)
2017-11-03 04:46:31,308 [salt.fileclient  ][INFO    ][25071] Caching directory '_returners/' for environment 'base'
2017-11-03 04:46:31,344 [salt.utils.extmods][INFO    ][25071] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-03 04:46:31,346 [salt.utils.extmods][INFO    ][25071] Syncing output for environment 'base'
2017-11-03 04:46:31,346 [salt.utils.extmods][INFO    ][25071] Loading cache from salt://_output, for base)
2017-11-03 04:46:31,346 [salt.fileclient  ][INFO    ][25071] Caching directory '_output/' for environment 'base'
2017-11-03 04:46:31,661 [salt.utils.extmods][INFO    ][25071] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-03 04:46:31,664 [salt.utils.extmods][INFO    ][25071] Syncing utils for environment 'base'
2017-11-03 04:46:31,664 [salt.utils.extmods][INFO    ][25071] Loading cache from salt://_utils, for base)
2017-11-03 04:46:31,664 [salt.fileclient  ][INFO    ][25071] Caching directory '_utils/' for environment 'base'
2017-11-03 04:46:31,722 [salt.utils.extmods][INFO    ][25071] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-03 04:46:31,724 [salt.utils.extmods][INFO    ][25071] Syncing log_handlers for environment 'base'
2017-11-03 04:46:31,724 [salt.utils.extmods][INFO    ][25071] Loading cache from salt://_log_handlers, for base)
2017-11-03 04:46:31,724 [salt.fileclient  ][INFO    ][25071] Caching directory '_log_handlers/' for environment 'base'
2017-11-03 04:46:31,745 [salt.utils.extmods][INFO    ][25071] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-03 04:46:31,747 [salt.utils.extmods][INFO    ][25071] Syncing proxy for environment 'base'
2017-11-03 04:46:31,747 [salt.utils.extmods][INFO    ][25071] Loading cache from salt://_proxy, for base)
2017-11-03 04:46:31,748 [salt.fileclient  ][INFO    ][25071] Caching directory '_proxy/' for environment 'base'
2017-11-03 04:46:31,764 [salt.utils.extmods][INFO    ][25071] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-03 04:46:31,767 [salt.utils.extmods][INFO    ][25071] Syncing engines for environment 'base'
2017-11-03 04:46:31,767 [salt.utils.extmods][INFO    ][25071] Loading cache from salt://_engines, for base)
2017-11-03 04:46:31,767 [salt.fileclient  ][INFO    ][25071] Caching directory '_engines/' for environment 'base'
2017-11-03 04:46:31,839 [salt.minion      ][INFO    ][25071] Returning information for job: 20171103044626302009
2017-11-03 05:11:15,805 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command test.ping with jid 20171103051115792423
2017-11-03 05:11:15,823 [salt.minion      ][INFO    ][25622] Starting a new job with PID 25622
2017-11-03 05:11:15,848 [salt.minion      ][INFO    ][25622] Returning information for job: 20171103051115792423
2017-11-03 05:11:44,657 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command state.sls with jid 20171103051144644829
2017-11-03 05:11:44,671 [salt.minion      ][INFO    ][25633] Starting a new job with PID 25633
2017-11-03 05:11:46,169 [salt.state       ][INFO    ][25633] Loading fresh modules for state activity
2017-11-03 05:11:46,260 [salt.fileclient  ][INFO    ][25633] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-03 05:11:46,278 [salt.fileclient  ][INFO    ][25633] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-03 05:11:46,301 [salt.fileclient  ][INFO    ][25633] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-03 05:11:46,590 [salt.state       ][INFO    ][25633] Running state [lsof] at time 05:11:46.589777
2017-11-03 05:11:46,590 [salt.state       ][INFO    ][25633] Executing state pkg.installed for lsof
2017-11-03 05:11:46,590 [salt.loaded.int.module.cmdmod][INFO    ][25633] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-03 05:11:46,868 [salt.state       ][INFO    ][25633] Package lsof is already installed
2017-11-03 05:11:46,868 [salt.state       ][INFO    ][25633] Completed state [lsof] at time 05:11:46.868126 duration_in_ms=278.349
2017-11-03 05:11:46,868 [salt.state       ][INFO    ][25633] Running state [keepalived] at time 05:11:46.868316
2017-11-03 05:11:46,869 [salt.state       ][INFO    ][25633] Executing state pkg.installed for keepalived
2017-11-03 05:11:46,885 [salt.loaded.int.module.cmdmod][INFO    ][25633] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-03 05:11:48,633 [salt.loaded.int.module.cmdmod][INFO    ][25633] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-11-03 05:11:54,703 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command saltutil.find_job with jid 20171103051154689928
2017-11-03 05:11:54,717 [salt.minion      ][INFO    ][27016] Starting a new job with PID 27016
2017-11-03 05:11:54,737 [salt.minion      ][INFO    ][27016] Returning information for job: 20171103051154689928
2017-11-03 05:11:56,391 [salt.loaded.int.module.cmdmod][INFO    ][25633] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-03 05:11:56,414 [salt.state       ][INFO    ][25633] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-11-03 05:11:56,421 [salt.state       ][INFO    ][25633] Loading fresh modules for state activity
2017-11-03 05:11:56,433 [salt.state       ][INFO    ][25633] Completed state [keepalived] at time 05:11:56.432947 duration_in_ms=9564.63
2017-11-03 05:11:56,435 [salt.state       ][INFO    ][25633] Running state [/etc/keepalived/keepalived.conf] at time 05:11:56.434651
2017-11-03 05:11:56,435 [salt.state       ][INFO    ][25633] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-03 05:11:56,467 [salt.fileclient  ][INFO    ][25633] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-03 05:11:56,499 [salt.fileclient  ][INFO    ][25633] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-03 05:11:56,506 [salt.state       ][INFO    ][25633] File changed:
New file
2017-11-03 05:11:56,506 [salt.state       ][INFO    ][25633] Completed state [/etc/keepalived/keepalived.conf] at time 05:11:56.505895 duration_in_ms=71.244
2017-11-03 05:11:56,564 [salt.state       ][INFO    ][25633] Running state [keepalived] at time 05:11:56.563464
2017-11-03 05:11:56,564 [salt.state       ][INFO    ][25633] Executing state service.running for keepalived
2017-11-03 05:11:56,565 [salt.loaded.int.module.cmdmod][INFO    ][25633] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-03 05:11:56,574 [salt.loaded.int.module.cmdmod][INFO    ][25633] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-03 05:11:56,582 [salt.loaded.int.module.cmdmod][INFO    ][25633] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-03 05:11:56,590 [salt.loaded.int.module.cmdmod][INFO    ][25633] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-03 05:11:56,599 [salt.loaded.int.module.cmdmod][INFO    ][25633] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-03 05:11:56,664 [salt.loaded.int.module.cmdmod][INFO    ][25633] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-03 05:11:56,672 [salt.loaded.int.module.cmdmod][INFO    ][25633] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-03 05:11:56,680 [salt.loaded.int.module.cmdmod][INFO    ][25633] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-03 05:11:56,688 [salt.state       ][INFO    ][25633] {'keepalived': True}
2017-11-03 05:11:56,688 [salt.state       ][INFO    ][25633] Completed state [keepalived] at time 05:11:56.688428 duration_in_ms=124.964
2017-11-03 05:11:56,689 [salt.minion      ][INFO    ][25633] Returning information for job: 20171103051144644829
2017-11-03 05:15:05,735 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command pillar.get with jid 20171103051505721938
2017-11-03 05:15:05,752 [salt.minion      ][INFO    ][27300] Starting a new job with PID 27300
2017-11-03 05:15:05,757 [salt.minion      ][INFO    ][27300] Returning information for job: 20171103051505721938
2017-11-03 05:21:19,601 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command state.sls with jid 20171103052119591675
2017-11-03 05:21:19,617 [salt.minion      ][INFO    ][27439] Starting a new job with PID 27439
2017-11-03 05:21:21,140 [salt.state       ][INFO    ][27439] Loading fresh modules for state activity
2017-11-03 05:21:21,163 [salt.fileclient  ][INFO    ][27439] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-03 05:21:21,184 [salt.fileclient  ][INFO    ][27439] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-03 05:21:21,445 [salt.state       ][INFO    ][27439] Running state [attr] at time 05:21:21.445025
2017-11-03 05:21:21,445 [salt.state       ][INFO    ][27439] Executing state pkg.installed for attr
2017-11-03 05:21:21,446 [salt.loaded.int.module.cmdmod][INFO    ][27439] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-03 05:21:21,712 [salt.loaded.int.module.cmdmod][INFO    ][27439] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-03 05:21:23,635 [salt.loaded.int.module.cmdmod][INFO    ][27439] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-11-03 05:21:26,418 [salt.loaded.int.module.cmdmod][INFO    ][27439] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-03 05:21:26,441 [salt.state       ][INFO    ][27439] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-03 05:21:26,449 [salt.state       ][INFO    ][27439] Loading fresh modules for state activity
2017-11-03 05:21:26,460 [salt.state       ][INFO    ][27439] Completed state [attr] at time 05:21:26.460379 duration_in_ms=5015.355
2017-11-03 05:21:26,465 [salt.state       ][INFO    ][27439] Running state [glusterfs-server] at time 05:21:26.464586
2017-11-03 05:21:26,465 [salt.state       ][INFO    ][27439] Executing state pkg.installed for glusterfs-server
2017-11-03 05:21:26,652 [salt.loaded.int.module.cmdmod][INFO    ][27439] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-11-03 05:21:29,695 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command saltutil.find_job with jid 20171103052129682414
2017-11-03 05:21:29,710 [salt.minion      ][INFO    ][28506] Starting a new job with PID 28506
2017-11-03 05:21:29,731 [salt.minion      ][INFO    ][28506] Returning information for job: 20171103052129682414
2017-11-03 05:21:39,894 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command saltutil.find_job with jid 20171103052139882119
2017-11-03 05:21:39,908 [salt.minion      ][INFO    ][31349] Starting a new job with PID 31349
2017-11-03 05:21:39,925 [salt.minion      ][INFO    ][31349] Returning information for job: 20171103052139882119
2017-11-03 05:21:43,922 [salt.loaded.int.module.cmdmod][INFO    ][27439] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-03 05:21:43,945 [salt.state       ][INFO    ][27439] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-11-03 05:21:43,953 [salt.state       ][INFO    ][27439] Loading fresh modules for state activity
2017-11-03 05:21:43,964 [salt.state       ][INFO    ][27439] Completed state [glusterfs-server] at time 05:21:43.964328 duration_in_ms=17499.741
2017-11-03 05:21:43,968 [salt.state       ][INFO    ][27439] Running state [bc] at time 05:21:43.968154
2017-11-03 05:21:43,968 [salt.state       ][INFO    ][27439] Executing state pkg.installed for bc
2017-11-03 05:21:44,216 [salt.loaded.int.module.cmdmod][INFO    ][27439] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-11-03 05:21:47,090 [salt.loaded.int.module.cmdmod][INFO    ][27439] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-03 05:21:47,117 [salt.state       ][INFO    ][27439] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-03 05:21:47,125 [salt.state       ][INFO    ][27439] Loading fresh modules for state activity
2017-11-03 05:21:47,141 [salt.state       ][INFO    ][27439] Completed state [bc] at time 05:21:47.140846 duration_in_ms=3172.691
2017-11-03 05:21:47,210 [salt.state       ][INFO    ][27439] Running state [glusterfs-server] at time 05:21:47.210262
2017-11-03 05:21:47,211 [salt.state       ][INFO    ][27439] Executing state service.running for glusterfs-server
2017-11-03 05:21:47,212 [salt.loaded.int.module.cmdmod][INFO    ][27439] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-03 05:21:47,222 [salt.loaded.int.module.cmdmod][INFO    ][27439] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-03 05:21:47,230 [salt.loaded.int.module.cmdmod][INFO    ][27439] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-03 05:21:47,239 [salt.state       ][INFO    ][27439] The service glusterfs-server is already running
2017-11-03 05:21:47,239 [salt.state       ][INFO    ][27439] Completed state [glusterfs-server] at time 05:21:47.239283 duration_in_ms=29.02
2017-11-03 05:21:47,241 [salt.state       ][INFO    ][27439] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 05:21:47.240793
2017-11-03 05:21:47,241 [salt.state       ][INFO    ][27439] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-03 05:21:47,257 [salt.state       ][INFO    ][27439] File changed:
New file
2017-11-03 05:21:47,258 [salt.state       ][INFO    ][27439] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 05:21:47.257692 duration_in_ms=16.898
2017-11-03 05:21:47,258 [salt.state       ][INFO    ][27439] Running state [/srv/glusterfs/glance] at time 05:21:47.257961
2017-11-03 05:21:47,258 [salt.state       ][INFO    ][27439] Executing state file.directory for /srv/glusterfs/glance
2017-11-03 05:21:47,259 [salt.state       ][INFO    ][27439] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-03 05:21:47,259 [salt.state       ][INFO    ][27439] Completed state [/srv/glusterfs/glance] at time 05:21:47.259072 duration_in_ms=1.112
2017-11-03 05:21:47,259 [salt.state       ][INFO    ][27439] Running state [/srv/glusterfs/keystone-keys] at time 05:21:47.259232
2017-11-03 05:21:47,259 [salt.state       ][INFO    ][27439] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-03 05:21:47,260 [salt.state       ][INFO    ][27439] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-03 05:21:47,260 [salt.state       ][INFO    ][27439] Completed state [/srv/glusterfs/keystone-keys] at time 05:21:47.259929 duration_in_ms=0.697
2017-11-03 05:21:47,260 [salt.state       ][INFO    ][27439] Running state [/srv/glusterfs/nova_instances] at time 05:21:47.260084
2017-11-03 05:21:47,260 [salt.state       ][INFO    ][27439] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-03 05:21:47,261 [salt.state       ][INFO    ][27439] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-03 05:21:47,261 [salt.state       ][INFO    ][27439] Completed state [/srv/glusterfs/nova_instances] at time 05:21:47.260747 duration_in_ms=0.664
2017-11-03 05:21:47,261 [salt.state       ][INFO    ][27439] Running state [/srv/glusterfs/keystone-credential-keys] at time 05:21:47.260904
2017-11-03 05:21:47,261 [salt.state       ][INFO    ][27439] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-03 05:21:47,261 [salt.state       ][INFO    ][27439] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-03 05:21:47,262 [salt.state       ][INFO    ][27439] Completed state [/srv/glusterfs/keystone-credential-keys] at time 05:21:47.261591 duration_in_ms=0.688
2017-11-03 05:21:47,262 [salt.minion      ][INFO    ][27439] Returning information for job: 20171103052119591675
2017-11-03 05:21:49,235 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command test.ping with jid 20171103052149221753
2017-11-03 05:21:49,250 [salt.minion      ][INFO    ][32233] Starting a new job with PID 32233
2017-11-03 05:21:49,276 [salt.minion      ][INFO    ][32233] Returning information for job: 20171103052149221753
2017-11-03 05:22:29,678 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command state.sls with jid 20171103052229665847
2017-11-03 05:22:29,695 [salt.minion      ][INFO    ][32456] Starting a new job with PID 32456
2017-11-03 05:22:31,174 [salt.state       ][INFO    ][32456] Loading fresh modules for state activity
2017-11-03 05:22:31,196 [salt.fileclient  ][INFO    ][32456] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-03 05:22:31,231 [salt.fileclient  ][INFO    ][32456] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-03 05:22:31,295 [salt.fileclient  ][INFO    ][32456] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-03 05:22:31,314 [salt.fileclient  ][INFO    ][32456] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-03 05:22:31,589 [salt.state       ][INFO    ][32456] Running state [attr] at time 05:22:31.589309
2017-11-03 05:22:31,590 [salt.state       ][INFO    ][32456] Executing state pkg.installed for attr
2017-11-03 05:22:31,590 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-03 05:22:31,844 [salt.state       ][INFO    ][32456] Package attr is already installed
2017-11-03 05:22:31,844 [salt.state       ][INFO    ][32456] Completed state [attr] at time 05:22:31.844033 duration_in_ms=254.725
2017-11-03 05:22:31,844 [salt.state       ][INFO    ][32456] Running state [glusterfs-server] at time 05:22:31.844234
2017-11-03 05:22:31,844 [salt.state       ][INFO    ][32456] Executing state pkg.installed for glusterfs-server
2017-11-03 05:22:31,847 [salt.state       ][INFO    ][32456] Package glusterfs-server is already installed
2017-11-03 05:22:31,847 [salt.state       ][INFO    ][32456] Completed state [glusterfs-server] at time 05:22:31.847075 duration_in_ms=2.841
2017-11-03 05:22:31,847 [salt.state       ][INFO    ][32456] Running state [bc] at time 05:22:31.847226
2017-11-03 05:22:31,847 [salt.state       ][INFO    ][32456] Executing state pkg.installed for bc
2017-11-03 05:22:31,850 [salt.state       ][INFO    ][32456] Package bc is already installed
2017-11-03 05:22:31,850 [salt.state       ][INFO    ][32456] Completed state [bc] at time 05:22:31.849962 duration_in_ms=2.737
2017-11-03 05:22:31,851 [salt.state       ][INFO    ][32456] Running state [glusterfs-server] at time 05:22:31.850731
2017-11-03 05:22:31,851 [salt.state       ][INFO    ][32456] Executing state service.running for glusterfs-server
2017-11-03 05:22:31,851 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-03 05:22:31,862 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-03 05:22:31,907 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-03 05:22:31,922 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-03 05:22:31,929 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-03 05:22:31,938 [salt.state       ][INFO    ][32456] The service glusterfs-server is already running
2017-11-03 05:22:31,938 [salt.state       ][INFO    ][32456] Completed state [glusterfs-server] at time 05:22:31.938007 duration_in_ms=87.276
2017-11-03 05:22:31,939 [salt.state       ][INFO    ][32456] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 05:22:31.939458
2017-11-03 05:22:31,940 [salt.state       ][INFO    ][32456] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-03 05:22:31,951 [salt.state       ][INFO    ][32456] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-03 05:22:31,951 [salt.state       ][INFO    ][32456] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 05:22:31.951320 duration_in_ms=11.862
2017-11-03 05:22:31,952 [salt.state       ][INFO    ][32456] Running state [/srv/glusterfs/glance] at time 05:22:31.951482
2017-11-03 05:22:31,952 [salt.state       ][INFO    ][32456] Executing state file.directory for /srv/glusterfs/glance
2017-11-03 05:22:31,952 [salt.state       ][INFO    ][32456] Directory /srv/glusterfs/glance is in the correct state
2017-11-03 05:22:31,952 [salt.state       ][INFO    ][32456] Completed state [/srv/glusterfs/glance] at time 05:22:31.952112 duration_in_ms=0.631
2017-11-03 05:22:31,952 [salt.state       ][INFO    ][32456] Running state [/srv/glusterfs/keystone-keys] at time 05:22:31.952267
2017-11-03 05:22:31,952 [salt.state       ][INFO    ][32456] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-03 05:22:31,953 [salt.state       ][INFO    ][32456] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-03 05:22:31,953 [salt.state       ][INFO    ][32456] Completed state [/srv/glusterfs/keystone-keys] at time 05:22:31.952869 duration_in_ms=0.603
2017-11-03 05:22:31,953 [salt.state       ][INFO    ][32456] Running state [/srv/glusterfs/nova_instances] at time 05:22:31.953024
2017-11-03 05:22:31,953 [salt.state       ][INFO    ][32456] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-03 05:22:31,954 [salt.state       ][INFO    ][32456] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-03 05:22:31,954 [salt.state       ][INFO    ][32456] Completed state [/srv/glusterfs/nova_instances] at time 05:22:31.953645 duration_in_ms=0.621
2017-11-03 05:22:31,954 [salt.state       ][INFO    ][32456] Running state [/srv/glusterfs/keystone-credential-keys] at time 05:22:31.953797
2017-11-03 05:22:31,954 [salt.state       ][INFO    ][32456] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-03 05:22:31,954 [salt.state       ][INFO    ][32456] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-03 05:22:31,954 [salt.state       ][INFO    ][32456] Completed state [/srv/glusterfs/keystone-credential-keys] at time 05:22:31.954458 duration_in_ms=0.66
2017-11-03 05:22:32,005 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command ['git', '--version'] in directory '/root'
2017-11-03 05:22:32,093 [salt.state       ][INFO    ][32456] Running state [sleep 5] at time 05:22:32.092531
2017-11-03 05:22:32,093 [salt.state       ][INFO    ][32456] Executing state cmd.wait for sleep 5
2017-11-03 05:22:32,093 [salt.state       ][INFO    ][32456] No changes made for sleep 5
2017-11-03 05:22:32,093 [salt.state       ][INFO    ][32456] Completed state [sleep 5] at time 05:22:32.093086 duration_in_ms=0.556
2017-11-03 05:22:32,093 [salt.state       ][INFO    ][32456] Running state [10.167.4.141] at time 05:22:32.093461
2017-11-03 05:22:32,094 [salt.state       ][INFO    ][32456] Executing state glusterfs.peered for 10.167.4.141
2017-11-03 05:22:32,094 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:32,104 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:32,155 [salt.state       ][INFO    ][32456] Host 10.167.4.141 already peered
2017-11-03 05:22:32,155 [salt.state       ][INFO    ][32456] Completed state [10.167.4.141] at time 05:22:32.155445 duration_in_ms=61.983
2017-11-03 05:22:32,158 [salt.state       ][INFO    ][32456] Running state [10.167.4.142] at time 05:22:32.157624
2017-11-03 05:22:32,158 [salt.state       ][INFO    ][32456] Executing state glusterfs.peered for 10.167.4.142
2017-11-03 05:22:32,158 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:32,167 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:32,215 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:32,224 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:32,277 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:32,285 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:32,342 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:32,350 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:32,397 [salt.state       ][INFO    ][32456] {'new': {'kvm02.baremetal-mcp-ocata-odl-ha.local': ['10.167.4.142'], '10.167.4.141': []}, 'old': {'kvm02.baremetal-mcp-ocata-odl-ha.local': [], '10.167.4.141': []}}
2017-11-03 05:22:32,397 [salt.state       ][INFO    ][32456] Completed state [10.167.4.142] at time 05:22:32.397014 duration_in_ms=239.389
2017-11-03 05:22:32,399 [salt.state       ][INFO    ][32456] Running state [10.167.4.143] at time 05:22:32.399117
2017-11-03 05:22:32,399 [salt.state       ][INFO    ][32456] Executing state glusterfs.peered for 10.167.4.143
2017-11-03 05:22:32,400 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:32,408 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:32,460 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:32,468 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:32,519 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:32,527 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:32,576 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:32,584 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:32,630 [salt.state       ][INFO    ][32456] Peering with localhost is not needed
2017-11-03 05:22:32,631 [salt.state       ][INFO    ][32456] Completed state [10.167.4.143] at time 05:22:32.630474 duration_in_ms=231.357
2017-11-03 05:22:32,631 [salt.state       ][INFO    ][32456] Running state [glance] at time 05:22:32.631223
2017-11-03 05:22:32,631 [salt.state       ][INFO    ][32456] Executing state glusterfs.created for glance
2017-11-03 05:22:32,632 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:32,640 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:32,688 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:32,697 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:32,748 [salt.state       ][INFO    ][32456] Volume glance already exists and is started.
2017-11-03 05:22:32,748 [salt.state       ][INFO    ][32456] Completed state [glance] at time 05:22:32.748054 duration_in_ms=116.829
2017-11-03 05:22:32,751 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 05:22:32.750646
2017-11-03 05:22:32,751 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-03 05:22:32,751 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-03 05:22:32,801 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:32,801 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 05:22:32.800756 duration_in_ms=50.11
2017-11-03 05:22:32,801 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 05:22:32.801170
2017-11-03 05:22:32,801 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-03 05:22:32,802 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-03 05:22:32,849 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:32,850 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 05:22:32.849687 duration_in_ms=48.517
2017-11-03 05:22:32,850 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 05:22:32.850131
2017-11-03 05:22:32,850 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-03 05:22:32,851 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-03 05:22:32,900 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:32,900 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 05:22:32.899974 duration_in_ms=49.843
2017-11-03 05:22:32,900 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 05:22:32.900426
2017-11-03 05:22:32,901 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-03 05:22:32,901 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-03 05:22:32,950 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:32,950 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 05:22:32.949967 duration_in_ms=49.541
2017-11-03 05:22:32,950 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 05:22:32.950416
2017-11-03 05:22:32,951 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-03 05:22:32,951 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-03 05:22:32,998 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:32,999 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 05:22:32.998513 duration_in_ms=48.097
2017-11-03 05:22:32,999 [salt.state       ][INFO    ][32456] Running state [glance] at time 05:22:32.999420
2017-11-03 05:22:32,1000 [salt.state       ][INFO    ][32456] Executing state glusterfs.started for glance
2017-11-03 05:22:33,000 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:33,008 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:33,058 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:33,067 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:33,117 [salt.state       ][INFO    ][32456] Volume glance is already started
2017-11-03 05:22:33,117 [salt.state       ][INFO    ][32456] Completed state [glance] at time 05:22:33.117413 duration_in_ms=117.993
2017-11-03 05:22:33,118 [salt.state       ][INFO    ][32456] Running state [keystone-keys] at time 05:22:33.118230
2017-11-03 05:22:33,118 [salt.state       ][INFO    ][32456] Executing state glusterfs.created for keystone-keys
2017-11-03 05:22:33,119 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:33,128 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:33,176 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:33,185 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:33,236 [salt.state       ][INFO    ][32456] Volume keystone-keys already exists and is started.
2017-11-03 05:22:33,236 [salt.state       ][INFO    ][32456] Completed state [keystone-keys] at time 05:22:33.236148 duration_in_ms=117.917
2017-11-03 05:22:33,239 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 05:22:33.238825
2017-11-03 05:22:33,239 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-03 05:22:33,239 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-03 05:22:33,288 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:33,288 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 05:22:33.287895 duration_in_ms=49.07
2017-11-03 05:22:33,288 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 05:22:33.288329
2017-11-03 05:22:33,289 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-03 05:22:33,289 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-03 05:22:33,346 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:33,346 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 05:22:33.346047 duration_in_ms=57.717
2017-11-03 05:22:33,347 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 05:22:33.346498
2017-11-03 05:22:33,347 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-03 05:22:33,347 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-03 05:22:33,395 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:33,395 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 05:22:33.395083 duration_in_ms=48.584
2017-11-03 05:22:33,396 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 05:22:33.395496
2017-11-03 05:22:33,396 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-03 05:22:33,396 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-03 05:22:33,441 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:33,442 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 05:22:33.441696 duration_in_ms=46.199
2017-11-03 05:22:33,442 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 05:22:33.442196
2017-11-03 05:22:33,442 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-03 05:22:33,443 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-03 05:22:33,490 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:33,490 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 05:22:33.489758 duration_in_ms=47.562
2017-11-03 05:22:33,491 [salt.state       ][INFO    ][32456] Running state [keystone-keys] at time 05:22:33.490662
2017-11-03 05:22:33,491 [salt.state       ][INFO    ][32456] Executing state glusterfs.started for keystone-keys
2017-11-03 05:22:33,491 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:33,499 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:33,545 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:33,553 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:33,602 [salt.state       ][INFO    ][32456] Volume keystone-keys is already started
2017-11-03 05:22:33,603 [salt.state       ][INFO    ][32456] Completed state [keystone-keys] at time 05:22:33.602609 duration_in_ms=111.947
2017-11-03 05:22:33,604 [salt.state       ][INFO    ][32456] Running state [nova_instances] at time 05:22:33.603540
2017-11-03 05:22:33,604 [salt.state       ][INFO    ][32456] Executing state glusterfs.created for nova_instances
2017-11-03 05:22:33,604 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:33,613 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:33,659 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:33,668 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:33,720 [salt.state       ][INFO    ][32456] Volume nova_instances already exists and is started.
2017-11-03 05:22:33,721 [salt.state       ][INFO    ][32456] Completed state [nova_instances] at time 05:22:33.720507 duration_in_ms=116.967
2017-11-03 05:22:33,723 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 05:22:33.723214
2017-11-03 05:22:33,723 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-03 05:22:33,724 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-03 05:22:33,772 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:33,772 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 05:22:33.772043 duration_in_ms=48.828
2017-11-03 05:22:33,772 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 05:22:33.772467
2017-11-03 05:22:33,773 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-03 05:22:33,773 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-03 05:22:33,820 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:33,820 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 05:22:33.820444 duration_in_ms=47.977
2017-11-03 05:22:33,821 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 05:22:33.820855
2017-11-03 05:22:33,821 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-03 05:22:33,821 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-03 05:22:33,868 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:33,868 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 05:22:33.868179 duration_in_ms=47.324
2017-11-03 05:22:33,869 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 05:22:33.868560
2017-11-03 05:22:33,869 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-03 05:22:33,869 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-03 05:22:33,916 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:33,916 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 05:22:33.916258 duration_in_ms=47.697
2017-11-03 05:22:33,917 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 05:22:33.916710
2017-11-03 05:22:33,917 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-03 05:22:33,917 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-03 05:22:33,965 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:33,965 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 05:22:33.965446 duration_in_ms=48.736
2017-11-03 05:22:33,966 [salt.state       ][INFO    ][32456] Running state [nova_instances] at time 05:22:33.966420
2017-11-03 05:22:33,967 [salt.state       ][INFO    ][32456] Executing state glusterfs.started for nova_instances
2017-11-03 05:22:33,967 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:33,976 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:34,028 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:34,036 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:34,091 [salt.state       ][INFO    ][32456] Volume nova_instances is already started
2017-11-03 05:22:34,091 [salt.state       ][INFO    ][32456] Completed state [nova_instances] at time 05:22:34.091062 duration_in_ms=124.642
2017-11-03 05:22:34,092 [salt.state       ][INFO    ][32456] Running state [keystone-credential-keys] at time 05:22:34.091851
2017-11-03 05:22:34,092 [salt.state       ][INFO    ][32456] Executing state glusterfs.created for keystone-credential-keys
2017-11-03 05:22:34,093 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:34,101 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:34,150 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:34,158 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:34,210 [salt.state       ][INFO    ][32456] Volume keystone-credential-keys already exists and is started.
2017-11-03 05:22:34,210 [salt.state       ][INFO    ][32456] Completed state [keystone-credential-keys] at time 05:22:34.209989 duration_in_ms=118.138
2017-11-03 05:22:34,216 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 05:22:34.215464
2017-11-03 05:22:34,216 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-03 05:22:34,217 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-03 05:22:34,267 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:34,267 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 05:22:34.267073 duration_in_ms=51.609
2017-11-03 05:22:34,268 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 05:22:34.267501
2017-11-03 05:22:34,268 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-03 05:22:34,268 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-03 05:22:34,316 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:34,316 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 05:22:34.315972 duration_in_ms=48.471
2017-11-03 05:22:34,317 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 05:22:34.316496
2017-11-03 05:22:34,317 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-03 05:22:34,317 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-03 05:22:34,367 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:34,368 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 05:22:34.367482 duration_in_ms=50.984
2017-11-03 05:22:34,368 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 05:22:34.367994
2017-11-03 05:22:34,368 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-03 05:22:34,369 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-03 05:22:34,419 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:34,419 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 05:22:34.419152 duration_in_ms=51.157
2017-11-03 05:22:34,420 [salt.state       ][INFO    ][32456] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 05:22:34.419661
2017-11-03 05:22:34,420 [salt.state       ][INFO    ][32456] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-03 05:22:34,420 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-03 05:22:34,468 [salt.state       ][INFO    ][32456] unless execution succeeded
2017-11-03 05:22:34,468 [salt.state       ][INFO    ][32456] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 05:22:34.468189 duration_in_ms=48.527
2017-11-03 05:22:34,469 [salt.state       ][INFO    ][32456] Running state [keystone-credential-keys] at time 05:22:34.469148
2017-11-03 05:22:34,469 [salt.state       ][INFO    ][32456] Executing state glusterfs.started for keystone-credential-keys
2017-11-03 05:22:34,470 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:34,478 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:34,524 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --version' in directory '/root'
2017-11-03 05:22:34,532 [salt.loaded.int.module.cmdmod][INFO    ][32456] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 05:22:34,583 [salt.state       ][INFO    ][32456] Volume keystone-credential-keys is already started
2017-11-03 05:22:34,583 [salt.state       ][INFO    ][32456] Completed state [keystone-credential-keys] at time 05:22:34.583209 duration_in_ms=114.06
2017-11-03 05:22:34,586 [salt.minion      ][INFO    ][32456] Returning information for job: 20171103052229665847
2017-11-03 05:22:39,669 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command test.ping with jid 20171103052239656653
2017-11-03 05:22:39,683 [salt.minion      ][INFO    ][417] Starting a new job with PID 417
2017-11-03 05:22:39,713 [salt.minion      ][INFO    ][417] Returning information for job: 20171103052239656653
2017-11-03 05:22:40,102 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command cmd.run with jid 20171103052240089494
2017-11-03 05:22:40,118 [salt.minion      ][INFO    ][423] Starting a new job with PID 423
2017-11-03 05:22:40,122 [salt.loaded.int.module.cmdmod][INFO    ][423] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-03 05:22:40,234 [salt.minion      ][INFO    ][423] Returning information for job: 20171103052240089494
2017-11-03 05:44:57,325 [salt.utils.schedule][INFO    ][24813] Running scheduled job: __mine_interval
2017-11-03 06:20:35,146 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command test.ping with jid 20171103062035137714
2017-11-03 06:20:35,166 [salt.minion      ][INFO    ][1630] Starting a new job with PID 1630
2017-11-03 06:20:35,598 [salt.minion      ][INFO    ][1630] Returning information for job: 20171103062035137714
2017-11-03 06:20:40,136 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command state.sls with jid 20171103062040127344
2017-11-03 06:20:40,150 [salt.minion      ][INFO    ][1637] Starting a new job with PID 1637
2017-11-03 06:20:40,657 [salt.state       ][INFO    ][1637] Loading fresh modules for state activity
2017-11-03 06:20:40,683 [salt.fileclient  ][INFO    ][1637] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-03 06:20:40,708 [salt.fileclient  ][INFO    ][1637] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-03 06:20:40,745 [salt.fileclient  ][INFO    ][1637] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-03 06:20:41,625 [salt.state       ][INFO    ][1637] Running state [lsof] at time 06:20:41.624552
2017-11-03 06:20:41,625 [salt.state       ][INFO    ][1637] Executing state pkg.installed for lsof
2017-11-03 06:20:41,625 [salt.loaded.int.module.cmdmod][INFO    ][1637] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-03 06:20:42,245 [salt.state       ][INFO    ][1637] Package lsof is already installed
2017-11-03 06:20:42,245 [salt.state       ][INFO    ][1637] Completed state [lsof] at time 06:20:42.244874 duration_in_ms=620.322
2017-11-03 06:20:42,245 [salt.state       ][INFO    ][1637] Running state [keepalived] at time 06:20:42.245073
2017-11-03 06:20:42,245 [salt.state       ][INFO    ][1637] Executing state pkg.installed for keepalived
2017-11-03 06:20:42,248 [salt.state       ][INFO    ][1637] Package keepalived is already installed
2017-11-03 06:20:42,248 [salt.state       ][INFO    ][1637] Completed state [keepalived] at time 06:20:42.247983 duration_in_ms=2.909
2017-11-03 06:20:42,252 [salt.state       ][INFO    ][1637] Running state [/etc/keepalived/keepalived.conf] at time 06:20:42.251747
2017-11-03 06:20:42,252 [salt.state       ][INFO    ][1637] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-03 06:20:42,273 [salt.fileclient  ][INFO    ][1637] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-03 06:20:42,308 [salt.fileclient  ][INFO    ][1637] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-03 06:20:42,312 [salt.state       ][INFO    ][1637] File /etc/keepalived/keepalived.conf is in the correct state
2017-11-03 06:20:42,313 [salt.state       ][INFO    ][1637] Completed state [/etc/keepalived/keepalived.conf] at time 06:20:42.312571 duration_in_ms=60.824
2017-11-03 06:20:42,313 [salt.state       ][INFO    ][1637] Running state [keepalived] at time 06:20:42.313166
2017-11-03 06:20:42,313 [salt.state       ][INFO    ][1637] Executing state service.running for keepalived
2017-11-03 06:20:42,314 [salt.loaded.int.module.cmdmod][INFO    ][1637] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-03 06:20:42,370 [salt.loaded.int.module.cmdmod][INFO    ][1637] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-03 06:20:42,376 [salt.loaded.int.module.cmdmod][INFO    ][1637] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-03 06:20:42,383 [salt.state       ][INFO    ][1637] The service keepalived is already running
2017-11-03 06:20:42,383 [salt.state       ][INFO    ][1637] Completed state [keepalived] at time 06:20:42.383359 duration_in_ms=70.193
2017-11-03 06:20:42,384 [salt.minion      ][INFO    ][1637] Returning information for job: 20171103062040127344
2017-11-03 06:21:09,509 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command pillar.get with jid 20171103062109500240
2017-11-03 06:21:09,534 [salt.minion      ][INFO    ][1665] Starting a new job with PID 1665
2017-11-03 06:21:09,539 [salt.minion      ][INFO    ][1665] Returning information for job: 20171103062109500240
2017-11-03 06:21:47,459 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command state.sls with jid 20171103062147449961
2017-11-03 06:21:47,475 [salt.minion      ][INFO    ][1685] Starting a new job with PID 1685
2017-11-03 06:21:47,885 [salt.state       ][INFO    ][1685] Loading fresh modules for state activity
2017-11-03 06:21:47,904 [salt.fileclient  ][INFO    ][1685] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-03 06:21:47,925 [salt.fileclient  ][INFO    ][1685] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-03 06:21:48,196 [salt.state       ][INFO    ][1685] Running state [attr] at time 06:21:48.195526
2017-11-03 06:21:48,196 [salt.state       ][INFO    ][1685] Executing state pkg.installed for attr
2017-11-03 06:21:48,196 [salt.loaded.int.module.cmdmod][INFO    ][1685] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-03 06:21:48,451 [salt.state       ][INFO    ][1685] Package attr is already installed
2017-11-03 06:21:48,451 [salt.state       ][INFO    ][1685] Completed state [attr] at time 06:21:48.451305 duration_in_ms=255.778
2017-11-03 06:21:48,452 [salt.state       ][INFO    ][1685] Running state [glusterfs-server] at time 06:21:48.451585
2017-11-03 06:21:48,452 [salt.state       ][INFO    ][1685] Executing state pkg.installed for glusterfs-server
2017-11-03 06:21:48,455 [salt.state       ][INFO    ][1685] Package glusterfs-server is already installed
2017-11-03 06:21:48,455 [salt.state       ][INFO    ][1685] Completed state [glusterfs-server] at time 06:21:48.454681 duration_in_ms=3.095
2017-11-03 06:21:48,455 [salt.state       ][INFO    ][1685] Running state [bc] at time 06:21:48.454880
2017-11-03 06:21:48,455 [salt.state       ][INFO    ][1685] Executing state pkg.installed for bc
2017-11-03 06:21:48,458 [salt.state       ][INFO    ][1685] Package bc is already installed
2017-11-03 06:21:48,458 [salt.state       ][INFO    ][1685] Completed state [bc] at time 06:21:48.457902 duration_in_ms=3.022
2017-11-03 06:21:48,459 [salt.state       ][INFO    ][1685] Running state [glusterfs-server] at time 06:21:48.458645
2017-11-03 06:21:48,459 [salt.state       ][INFO    ][1685] Executing state service.running for glusterfs-server
2017-11-03 06:21:48,459 [salt.loaded.int.module.cmdmod][INFO    ][1685] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-03 06:21:48,475 [salt.loaded.int.module.cmdmod][INFO    ][1685] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-03 06:21:48,481 [salt.loaded.int.module.cmdmod][INFO    ][1685] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-03 06:21:48,529 [salt.state       ][INFO    ][1685] The service glusterfs-server is already running
2017-11-03 06:21:48,529 [salt.state       ][INFO    ][1685] Completed state [glusterfs-server] at time 06:21:48.529017 duration_in_ms=70.371
2017-11-03 06:21:48,531 [salt.state       ][INFO    ][1685] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:21:48.530784
2017-11-03 06:21:48,531 [salt.state       ][INFO    ][1685] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-03 06:21:48,545 [salt.state       ][INFO    ][1685] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-03 06:21:48,545 [salt.state       ][INFO    ][1685] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:21:48.544862 duration_in_ms=14.078
2017-11-03 06:21:48,545 [salt.state       ][INFO    ][1685] Running state [/srv/glusterfs/glance] at time 06:21:48.545067
2017-11-03 06:21:48,545 [salt.state       ][INFO    ][1685] Executing state file.directory for /srv/glusterfs/glance
2017-11-03 06:21:48,546 [salt.state       ][INFO    ][1685] Directory /srv/glusterfs/glance is in the correct state
2017-11-03 06:21:48,546 [salt.state       ][INFO    ][1685] Completed state [/srv/glusterfs/glance] at time 06:21:48.545923 duration_in_ms=0.856
2017-11-03 06:21:48,546 [salt.state       ][INFO    ][1685] Running state [/srv/glusterfs/keystone-keys] at time 06:21:48.546169
2017-11-03 06:21:48,546 [salt.state       ][INFO    ][1685] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-03 06:21:48,547 [salt.state       ][INFO    ][1685] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-03 06:21:48,547 [salt.state       ][INFO    ][1685] Completed state [/srv/glusterfs/keystone-keys] at time 06:21:48.546966 duration_in_ms=0.796
2017-11-03 06:21:48,547 [salt.state       ][INFO    ][1685] Running state [/srv/glusterfs/nova_instances] at time 06:21:48.547155
2017-11-03 06:21:48,547 [salt.state       ][INFO    ][1685] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-03 06:21:48,548 [salt.state       ][INFO    ][1685] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-03 06:21:48,548 [salt.state       ][INFO    ][1685] Completed state [/srv/glusterfs/nova_instances] at time 06:21:48.547932 duration_in_ms=0.777
2017-11-03 06:21:48,548 [salt.state       ][INFO    ][1685] Running state [/srv/glusterfs/keystone-credential-keys] at time 06:21:48.548123
2017-11-03 06:21:48,548 [salt.state       ][INFO    ][1685] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-03 06:21:48,549 [salt.state       ][INFO    ][1685] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-03 06:21:48,549 [salt.state       ][INFO    ][1685] Completed state [/srv/glusterfs/keystone-credential-keys] at time 06:21:48.548905 duration_in_ms=0.781
2017-11-03 06:21:48,550 [salt.minion      ][INFO    ][1685] Returning information for job: 20171103062147449961
2017-11-03 06:21:49,772 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command test.ping with jid 20171103062149762968
2017-11-03 06:21:49,787 [salt.minion      ][INFO    ][1708] Starting a new job with PID 1708
2017-11-03 06:21:49,813 [salt.minion      ][INFO    ][1708] Returning information for job: 20171103062149762968
2017-11-03 06:21:54,943 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command state.sls with jid 20171103062154938426
2017-11-03 06:21:54,958 [salt.minion      ][INFO    ][1714] Starting a new job with PID 1714
2017-11-03 06:21:55,374 [salt.state       ][INFO    ][1714] Loading fresh modules for state activity
2017-11-03 06:21:55,396 [salt.fileclient  ][INFO    ][1714] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-03 06:21:55,430 [salt.fileclient  ][INFO    ][1714] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-03 06:21:55,493 [salt.fileclient  ][INFO    ][1714] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-03 06:21:55,513 [salt.fileclient  ][INFO    ][1714] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-03 06:21:55,769 [salt.state       ][INFO    ][1714] Running state [attr] at time 06:21:55.769427
2017-11-03 06:21:55,770 [salt.state       ][INFO    ][1714] Executing state pkg.installed for attr
2017-11-03 06:21:55,770 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-03 06:21:56,055 [salt.state       ][INFO    ][1714] Package attr is already installed
2017-11-03 06:21:56,055 [salt.state       ][INFO    ][1714] Completed state [attr] at time 06:21:56.054892 duration_in_ms=285.465
2017-11-03 06:21:56,055 [salt.state       ][INFO    ][1714] Running state [glusterfs-server] at time 06:21:56.055092
2017-11-03 06:21:56,055 [salt.state       ][INFO    ][1714] Executing state pkg.installed for glusterfs-server
2017-11-03 06:21:56,058 [salt.state       ][INFO    ][1714] Package glusterfs-server is already installed
2017-11-03 06:21:56,058 [salt.state       ][INFO    ][1714] Completed state [glusterfs-server] at time 06:21:56.057937 duration_in_ms=2.846
2017-11-03 06:21:56,058 [salt.state       ][INFO    ][1714] Running state [bc] at time 06:21:56.058072
2017-11-03 06:21:56,058 [salt.state       ][INFO    ][1714] Executing state pkg.installed for bc
2017-11-03 06:21:56,061 [salt.state       ][INFO    ][1714] Package bc is already installed
2017-11-03 06:21:56,061 [salt.state       ][INFO    ][1714] Completed state [bc] at time 06:21:56.060789 duration_in_ms=2.717
2017-11-03 06:21:56,062 [salt.state       ][INFO    ][1714] Running state [glusterfs-server] at time 06:21:56.061582
2017-11-03 06:21:56,062 [salt.state       ][INFO    ][1714] Executing state service.running for glusterfs-server
2017-11-03 06:21:56,062 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-03 06:21:56,078 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-03 06:21:56,085 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-03 06:21:56,093 [salt.state       ][INFO    ][1714] The service glusterfs-server is already running
2017-11-03 06:21:56,094 [salt.state       ][INFO    ][1714] Completed state [glusterfs-server] at time 06:21:56.093709 duration_in_ms=32.125
2017-11-03 06:21:56,095 [salt.state       ][INFO    ][1714] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:21:56.095369
2017-11-03 06:21:56,096 [salt.state       ][INFO    ][1714] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-03 06:21:56,103 [salt.state       ][INFO    ][1714] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-03 06:21:56,104 [salt.state       ][INFO    ][1714] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:21:56.103607 duration_in_ms=8.238
2017-11-03 06:21:56,104 [salt.state       ][INFO    ][1714] Running state [/srv/glusterfs/glance] at time 06:21:56.103817
2017-11-03 06:21:56,104 [salt.state       ][INFO    ][1714] Executing state file.directory for /srv/glusterfs/glance
2017-11-03 06:21:56,105 [salt.state       ][INFO    ][1714] Directory /srv/glusterfs/glance is in the correct state
2017-11-03 06:21:56,105 [salt.state       ][INFO    ][1714] Completed state [/srv/glusterfs/glance] at time 06:21:56.104661 duration_in_ms=0.845
2017-11-03 06:21:56,105 [salt.state       ][INFO    ][1714] Running state [/srv/glusterfs/keystone-keys] at time 06:21:56.104856
2017-11-03 06:21:56,105 [salt.state       ][INFO    ][1714] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-03 06:21:56,106 [salt.state       ][INFO    ][1714] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-03 06:21:56,106 [salt.state       ][INFO    ][1714] Completed state [/srv/glusterfs/keystone-keys] at time 06:21:56.105652 duration_in_ms=0.796
2017-11-03 06:21:56,106 [salt.state       ][INFO    ][1714] Running state [/srv/glusterfs/nova_instances] at time 06:21:56.105844
2017-11-03 06:21:56,106 [salt.state       ][INFO    ][1714] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-03 06:21:56,107 [salt.state       ][INFO    ][1714] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-03 06:21:56,107 [salt.state       ][INFO    ][1714] Completed state [/srv/glusterfs/nova_instances] at time 06:21:56.106666 duration_in_ms=0.821
2017-11-03 06:21:56,107 [salt.state       ][INFO    ][1714] Running state [/srv/glusterfs/keystone-credential-keys] at time 06:21:56.106853
2017-11-03 06:21:56,107 [salt.state       ][INFO    ][1714] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-03 06:21:56,107 [salt.state       ][INFO    ][1714] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-03 06:21:56,108 [salt.state       ][INFO    ][1714] Completed state [/srv/glusterfs/keystone-credential-keys] at time 06:21:56.107645 duration_in_ms=0.792
2017-11-03 06:21:56,162 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command ['git', '--version'] in directory '/root'
2017-11-03 06:21:56,407 [salt.state       ][INFO    ][1714] Running state [sleep 5] at time 06:21:56.407010
2017-11-03 06:21:56,407 [salt.state       ][INFO    ][1714] Executing state cmd.wait for sleep 5
2017-11-03 06:21:56,407 [salt.state       ][INFO    ][1714] No changes made for sleep 5
2017-11-03 06:21:56,408 [salt.state       ][INFO    ][1714] Completed state [sleep 5] at time 06:21:56.407580 duration_in_ms=0.57
2017-11-03 06:21:56,408 [salt.state       ][INFO    ][1714] Running state [10.167.4.141] at time 06:21:56.407958
2017-11-03 06:21:56,408 [salt.state       ][INFO    ][1714] Executing state glusterfs.peered for 10.167.4.141
2017-11-03 06:21:56,408 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:56,418 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:56,696 [salt.state       ][INFO    ][1714] Host 10.167.4.141 already peered
2017-11-03 06:21:56,696 [salt.state       ][INFO    ][1714] Completed state [10.167.4.141] at time 06:21:56.695959 duration_in_ms=288.0
2017-11-03 06:21:56,698 [salt.state       ][INFO    ][1714] Running state [10.167.4.142] at time 06:21:56.698374
2017-11-03 06:21:56,699 [salt.state       ][INFO    ][1714] Executing state glusterfs.peered for 10.167.4.142
2017-11-03 06:21:56,699 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:56,709 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:56,762 [salt.state       ][INFO    ][1714] Host 10.167.4.142 already peered
2017-11-03 06:21:56,763 [salt.state       ][INFO    ][1714] Completed state [10.167.4.142] at time 06:21:56.762729 duration_in_ms=64.354
2017-11-03 06:21:56,765 [salt.state       ][INFO    ][1714] Running state [10.167.4.143] at time 06:21:56.765090
2017-11-03 06:21:56,765 [salt.state       ][INFO    ][1714] Executing state glusterfs.peered for 10.167.4.143
2017-11-03 06:21:56,766 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:56,775 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:56,825 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:56,833 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:56,885 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:56,893 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:56,943 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:56,952 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:57,005 [salt.state       ][INFO    ][1714] Peering with localhost is not needed
2017-11-03 06:21:57,005 [salt.state       ][INFO    ][1714] Completed state [10.167.4.143] at time 06:21:57.005201 duration_in_ms=240.111
2017-11-03 06:21:57,006 [salt.state       ][INFO    ][1714] Running state [glance] at time 06:21:57.005947
2017-11-03 06:21:57,006 [salt.state       ][INFO    ][1714] Executing state glusterfs.created for glance
2017-11-03 06:21:57,007 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:57,015 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:57,062 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:57,070 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:57,121 [salt.state       ][INFO    ][1714] Volume glance already exists and is started.
2017-11-03 06:21:57,122 [salt.state       ][INFO    ][1714] Completed state [glance] at time 06:21:57.121568 duration_in_ms=115.621
2017-11-03 06:21:57,124 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:57.124353
2017-11-03 06:21:57,125 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-03 06:21:57,125 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-03 06:21:57,174 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:57,174 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:57.174252 duration_in_ms=49.899
2017-11-03 06:21:57,175 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 06:21:57.174718
2017-11-03 06:21:57,175 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-03 06:21:57,175 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-03 06:21:57,224 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:57,224 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 06:21:57.224225 duration_in_ms=49.507
2017-11-03 06:21:57,225 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 06:21:57.224681
2017-11-03 06:21:57,225 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-03 06:21:57,225 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-03 06:21:57,278 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:57,279 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 06:21:57.278493 duration_in_ms=53.812
2017-11-03 06:21:57,279 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:57.278913
2017-11-03 06:21:57,279 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-03 06:21:57,280 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-03 06:21:57,327 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:57,328 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:57.327617 duration_in_ms=48.704
2017-11-03 06:21:57,328 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 06:21:57.328079
2017-11-03 06:21:57,328 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-03 06:21:57,329 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-03 06:21:57,379 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:57,379 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 06:21:57.378856 duration_in_ms=50.777
2017-11-03 06:21:57,380 [salt.state       ][INFO    ][1714] Running state [glance] at time 06:21:57.379782
2017-11-03 06:21:57,380 [salt.state       ][INFO    ][1714] Executing state glusterfs.started for glance
2017-11-03 06:21:57,380 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:57,389 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:57,437 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:57,446 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:57,500 [salt.state       ][INFO    ][1714] Volume glance is already started
2017-11-03 06:21:57,500 [salt.state       ][INFO    ][1714] Completed state [glance] at time 06:21:57.500418 duration_in_ms=120.635
2017-11-03 06:21:57,501 [salt.state       ][INFO    ][1714] Running state [keystone-keys] at time 06:21:57.501182
2017-11-03 06:21:57,501 [salt.state       ][INFO    ][1714] Executing state glusterfs.created for keystone-keys
2017-11-03 06:21:57,502 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:57,511 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:57,560 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:57,568 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:57,620 [salt.state       ][INFO    ][1714] Volume keystone-keys already exists and is started.
2017-11-03 06:21:57,620 [salt.state       ][INFO    ][1714] Completed state [keystone-keys] at time 06:21:57.619750 duration_in_ms=118.568
2017-11-03 06:21:57,622 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 06:21:57.622446
2017-11-03 06:21:57,623 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-03 06:21:57,623 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-03 06:21:57,671 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:57,671 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 06:21:57.670926 duration_in_ms=48.48
2017-11-03 06:21:57,671 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:57.671357
2017-11-03 06:21:57,672 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-03 06:21:57,672 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-03 06:21:57,721 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:57,721 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:57.720868 duration_in_ms=49.511
2017-11-03 06:21:57,721 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:57.721314
2017-11-03 06:21:57,722 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-03 06:21:57,722 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-03 06:21:57,768 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:57,768 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:57.767762 duration_in_ms=46.448
2017-11-03 06:21:57,768 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 06:21:57.768156
2017-11-03 06:21:57,768 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-03 06:21:57,769 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-03 06:21:57,816 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:57,817 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 06:21:57.816614 duration_in_ms=48.458
2017-11-03 06:21:57,817 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 06:21:57.817069
2017-11-03 06:21:57,817 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-03 06:21:57,818 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-03 06:21:57,866 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:57,866 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 06:21:57.865776 duration_in_ms=48.702
2017-11-03 06:21:57,867 [salt.state       ][INFO    ][1714] Running state [keystone-keys] at time 06:21:57.866727
2017-11-03 06:21:57,867 [salt.state       ][INFO    ][1714] Executing state glusterfs.started for keystone-keys
2017-11-03 06:21:57,867 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:57,873 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:57,921 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:57,928 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:57,977 [salt.state       ][INFO    ][1714] Volume keystone-keys is already started
2017-11-03 06:21:57,978 [salt.state       ][INFO    ][1714] Completed state [keystone-keys] at time 06:21:57.977549 duration_in_ms=110.822
2017-11-03 06:21:57,979 [salt.state       ][INFO    ][1714] Running state [nova_instances] at time 06:21:57.978513
2017-11-03 06:21:57,979 [salt.state       ][INFO    ][1714] Executing state glusterfs.created for nova_instances
2017-11-03 06:21:57,979 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:57,987 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:58,033 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:58,041 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:58,092 [salt.state       ][INFO    ][1714] Volume nova_instances already exists and is started.
2017-11-03 06:21:58,092 [salt.state       ][INFO    ][1714] Completed state [nova_instances] at time 06:21:58.091890 duration_in_ms=113.376
2017-11-03 06:21:58,095 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:58.094597
2017-11-03 06:21:58,095 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-03 06:21:58,095 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-03 06:21:58,142 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:58,143 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:58.142586 duration_in_ms=47.989
2017-11-03 06:21:58,143 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 06:21:58.143028
2017-11-03 06:21:58,143 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-03 06:21:58,144 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-03 06:21:58,190 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:58,190 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 06:21:58.189766 duration_in_ms=46.738
2017-11-03 06:21:58,190 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 06:21:58.190160
2017-11-03 06:21:58,190 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-03 06:21:58,191 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-03 06:21:58,237 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:58,237 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 06:21:58.237387 duration_in_ms=47.226
2017-11-03 06:21:58,238 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 06:21:58.237854
2017-11-03 06:21:58,238 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-03 06:21:58,239 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-03 06:21:58,284 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:58,284 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 06:21:58.283884 duration_in_ms=46.028
2017-11-03 06:21:58,284 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:58.284281
2017-11-03 06:21:58,284 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-03 06:21:58,285 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-03 06:21:58,330 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:58,330 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:58.330451 duration_in_ms=46.169
2017-11-03 06:21:58,331 [salt.state       ][INFO    ][1714] Running state [nova_instances] at time 06:21:58.331280
2017-11-03 06:21:58,331 [salt.state       ][INFO    ][1714] Executing state glusterfs.started for nova_instances
2017-11-03 06:21:58,332 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:58,338 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:58,383 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:58,390 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:58,441 [salt.state       ][INFO    ][1714] Volume nova_instances is already started
2017-11-03 06:21:58,441 [salt.state       ][INFO    ][1714] Completed state [nova_instances] at time 06:21:58.440685 duration_in_ms=109.405
2017-11-03 06:21:58,442 [salt.state       ][INFO    ][1714] Running state [keystone-credential-keys] at time 06:21:58.441502
2017-11-03 06:21:58,442 [salt.state       ][INFO    ][1714] Executing state glusterfs.created for keystone-credential-keys
2017-11-03 06:21:58,442 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:58,448 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:58,495 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:58,502 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:58,552 [salt.state       ][INFO    ][1714] Volume keystone-credential-keys already exists and is started.
2017-11-03 06:21:58,552 [salt.state       ][INFO    ][1714] Completed state [keystone-credential-keys] at time 06:21:58.552147 duration_in_ms=110.645
2017-11-03 06:21:58,555 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 06:21:58.555088
2017-11-03 06:21:58,555 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-03 06:21:58,556 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-03 06:21:58,603 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:58,604 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 06:21:58.603929 duration_in_ms=48.839
2017-11-03 06:21:58,605 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:58.604522
2017-11-03 06:21:58,605 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-03 06:21:58,605 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-03 06:21:58,650 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:58,650 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:21:58.650439 duration_in_ms=45.916
2017-11-03 06:21:58,651 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 06:21:58.650828
2017-11-03 06:21:58,651 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-03 06:21:58,651 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-03 06:21:58,696 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:58,696 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 06:21:58.696366 duration_in_ms=45.537
2017-11-03 06:21:58,697 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:58.696823
2017-11-03 06:21:58,697 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-03 06:21:58,697 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-03 06:21:58,743 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:58,744 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:21:58.743559 duration_in_ms=46.735
2017-11-03 06:21:58,744 [salt.state       ][INFO    ][1714] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 06:21:58.743961
2017-11-03 06:21:58,744 [salt.state       ][INFO    ][1714] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-03 06:21:58,745 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-03 06:21:58,789 [salt.state       ][INFO    ][1714] unless execution succeeded
2017-11-03 06:21:58,790 [salt.state       ][INFO    ][1714] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 06:21:58.789486 duration_in_ms=45.524
2017-11-03 06:21:58,790 [salt.state       ][INFO    ][1714] Running state [keystone-credential-keys] at time 06:21:58.790458
2017-11-03 06:21:58,791 [salt.state       ][INFO    ][1714] Executing state glusterfs.started for keystone-credential-keys
2017-11-03 06:21:58,791 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:58,798 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:58,841 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --version' in directory '/root'
2017-11-03 06:21:58,848 [salt.loaded.int.module.cmdmod][INFO    ][1714] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-03 06:21:58,897 [salt.state       ][INFO    ][1714] Volume keystone-credential-keys is already started
2017-11-03 06:21:58,897 [salt.state       ][INFO    ][1714] Completed state [keystone-credential-keys] at time 06:21:58.897000 duration_in_ms=106.541
2017-11-03 06:21:58,899 [salt.minion      ][INFO    ][1714] Returning information for job: 20171103062154938426
2017-11-03 06:22:03,541 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command test.ping with jid 20171103062203537941
2017-11-03 06:22:03,554 [salt.minion      ][INFO    ][2098] Starting a new job with PID 2098
2017-11-03 06:22:03,579 [salt.minion      ][INFO    ][2098] Returning information for job: 20171103062203537941
2017-11-03 06:22:03,969 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command cmd.run with jid 20171103062203959955
2017-11-03 06:22:03,983 [salt.minion      ][INFO    ][2104] Starting a new job with PID 2104
2017-11-03 06:22:03,987 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-03 06:22:04,095 [salt.minion      ][INFO    ][2104] Returning information for job: 20171103062203959955
2017-11-03 06:44:57,324 [salt.utils.schedule][INFO    ][24813] Running scheduled job: __mine_interval
2017-11-03 06:51:28,643 [salt.minion      ][INFO    ][24813] User sudo_ubuntu Executing command cp.push_dir with jid 20171103065128632275
2017-11-03 06:51:28,659 [salt.minion      ][INFO    ][2760] Starting a new job with PID 2760
