2017-09-22 18:05:56,294 [salt.cli.daemons ][WARNING ][2539] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-22 18:47:23,944 [salt.state       ][ERROR   ][3876] No contents found in top file
2017-09-22 18:47:42,113 [salt.utils.parsers][WARNING ][2539] Minion received a SIGTERM. Exiting.
2017-09-22 18:50:04,822 [salt.cli.daemons ][WARNING ][3200] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-22 18:52:57,891 [salt.loaded.int.module.cmdmod][ERROR   ][10501] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-09-22 18:52:57,892 [salt.loaded.int.module.cmdmod][ERROR   ][10501] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-09-22 18:52:57,892 [salt.loaded.int.module.cmdmod][ERROR   ][10501] retcode: 1
2017-09-22 18:52:57,892 [salt.state       ][ERROR   ][10501] {'pid': 15287, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-09-22 18:53:01,801 [py.warnings      ][WARNING ][15328] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-09-22 18:54:03,185 [salt.loaded.int.module.cmdmod][ERROR   ][15328] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-22 18:54:03,186 [salt.loaded.int.module.cmdmod][ERROR   ][15328] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-22 18:54:10,912 [salt.loaded.int.module.cmdmod][ERROR   ][15328] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-22 18:54:10,912 [salt.loaded.int.module.cmdmod][ERROR   ][15328] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-22 18:54:21,080 [salt.loaded.int.module.cmdmod][ERROR   ][15328] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-22 18:54:21,081 [salt.loaded.int.module.cmdmod][ERROR   ][15328] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-22 18:54:32,362 [salt.loaded.int.module.cmdmod][ERROR   ][15328] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-22 18:54:32,363 [salt.loaded.int.module.cmdmod][ERROR   ][15328] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-22 18:54:40,519 [salt.loaded.int.module.cmdmod][ERROR   ][15328] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-22 18:54:40,520 [salt.loaded.int.module.cmdmod][ERROR   ][15328] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-22 18:54:48,556 [salt.loaded.int.module.cmdmod][ERROR   ][15328] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-09-22 18:54:52,046 [salt.state       ][ERROR   ][22891] No contents found in top file
2017-09-22 18:55:05,050 [salt.loaded.int.module.cmdmod][INFO    ][23386] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-22 18:55:05,061 [salt.loaded.int.module.cmdmod][INFO    ][23386] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-22 18:55:05,081 [salt.loaded.int.module.cmdmod][INFO    ][23386] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-22 18:55:05,095 [salt.utils.parsers][WARNING ][3200] Minion received a SIGTERM. Exiting.
2017-09-22 18:55:05,491 [salt.cli.daemons ][INFO    ][23524] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-ovs-ha.local"
2017-09-22 18:55:06,135 [salt.minion      ][INFO    ][23524] Creating minion process manager
2017-09-22 18:55:06,135 [salt.cli.daemons ][WARNING ][23524] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-22 18:55:06,136 [salt.cli.daemons ][INFO    ][23524] The Salt Minion is starting up
2017-09-22 18:55:06,136 [salt.minion      ][INFO    ][23524] Minion is starting as user 'root'
2017-09-22 18:55:06,136 [salt.utils.event ][INFO    ][23524] Starting pull socket on /var/run/salt/minion/minion_event_fd678c5357_pull.ipc
2017-09-22 18:55:07,327 [salt.loaded.int.module.cmdmod][INFO    ][23524] Executing command ['date', '+%z'] in directory '/root'
2017-09-22 18:55:07,349 [salt.utils.schedule][INFO    ][23524] Updating job settings for scheduled job: __mine_interval
2017-09-22 18:55:07,356 [salt.minion      ][INFO    ][23524] Added mine.update to scheduler
2017-09-22 18:55:07,565 [salt.minion      ][INFO    ][23524] Minion is ready to receive requests!
2017-09-22 18:55:08,567 [salt.utils.schedule][INFO    ][23524] Running scheduled job: __mine_interval
2017-09-22 18:55:14,374 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922185514360057
2017-09-22 18:55:14,395 [salt.minion      ][INFO    ][23628] Starting a new job with PID 23628
2017-09-22 18:55:14,412 [salt.minion      ][INFO    ][23628] Returning information for job: 20170922185514360057
2017-09-22 18:55:24,483 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922185524470964
2017-09-22 18:55:24,504 [salt.minion      ][INFO    ][23637] Starting a new job with PID 23637
2017-09-22 18:55:24,575 [salt.minion      ][INFO    ][23637] Returning information for job: 20170922185524470964
2017-09-22 18:55:34,682 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922185534669743
2017-09-22 18:55:34,703 [salt.minion      ][INFO    ][23642] Starting a new job with PID 23642
2017-09-22 18:55:34,733 [salt.minion      ][INFO    ][23642] Returning information for job: 20170922185534669743
2017-09-22 18:55:44,885 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922185544873177
2017-09-22 18:55:44,905 [salt.minion      ][INFO    ][23649] Starting a new job with PID 23649
2017-09-22 18:55:45,019 [salt.minion      ][INFO    ][23649] Returning information for job: 20170922185544873177
2017-09-22 18:55:55,076 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922185555062689
2017-09-22 18:55:55,095 [salt.minion      ][INFO    ][23655] Starting a new job with PID 23655
2017-09-22 18:55:55,112 [salt.minion      ][INFO    ][23655] Returning information for job: 20170922185555062689
2017-09-22 18:56:06,211 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command pillar.get with jid 20170922185606204012
2017-09-22 18:56:06,232 [salt.minion      ][INFO    ][23663] Starting a new job with PID 23663
2017-09-22 18:56:06,238 [salt.minion      ][INFO    ][23663] Returning information for job: 20170922185606204012
2017-09-22 18:57:17,078 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170922185717061874
2017-09-22 18:57:17,099 [salt.minion      ][INFO    ][23686] Starting a new job with PID 23686
2017-09-22 18:57:20,444 [salt.state       ][INFO    ][23686] Loading fresh modules for state activity
2017-09-22 18:57:20,481 [salt.state       ][ERROR   ][23686] No contents found in top file
2017-09-22 18:57:20,482 [salt.utils.extmods][INFO    ][23686] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-22 18:57:20,489 [salt.utils.extmods][INFO    ][23686] Syncing beacons for environment 'base'
2017-09-22 18:57:20,489 [salt.utils.extmods][INFO    ][23686] Loading cache from salt://_beacons, for base)
2017-09-22 18:57:20,489 [salt.fileclient  ][INFO    ][23686] Caching directory '_beacons/' for environment 'base'
2017-09-22 18:57:20,531 [salt.utils.extmods][INFO    ][23686] Syncing modules for environment 'base'
2017-09-22 18:57:20,532 [salt.utils.extmods][INFO    ][23686] Loading cache from salt://_modules, for base)
2017-09-22 18:57:20,532 [salt.fileclient  ][INFO    ][23686] Caching directory '_modules/' for environment 'base'
2017-09-22 18:57:20,591 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-22 18:57:20,818 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-22 18:57:20,831 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-22 18:57:20,855 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-22 18:57:20,883 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-22 18:57:20,894 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-22 18:57:20,911 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-22 18:57:20,924 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-22 18:57:20,937 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-22 18:57:20,967 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-22 18:57:21,030 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-22 18:57:21,047 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-22 18:57:21,078 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-22 18:57:21,137 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-22 18:57:21,152 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-22 18:57:21,169 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-22 18:57:21,204 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-22 18:57:21,216 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-22 18:57:21,253 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-22 18:57:21,284 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-22 18:57:21,322 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-22 18:57:21,409 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-22 18:57:21,498 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-22 18:57:21,516 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-22 18:57:21,532 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-22 18:57:21,554 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-22 18:57:21,572 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-22 18:57:21,599 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-22 18:57:21,614 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-22 18:57:21,655 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-22 18:57:21,693 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-22 18:57:21,707 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-22 18:57:21,713 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-22 18:57:21,713 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-22 18:57:21,713 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-22 18:57:21,714 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-22 18:57:21,715 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-22 18:57:21,715 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-22 18:57:21,715 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-22 18:57:21,716 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-22 18:57:21,716 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-22 18:57:21,717 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-22 18:57:21,717 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-22 18:57:21,717 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-22 18:57:21,718 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-22 18:57:21,718 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-22 18:57:21,719 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-22 18:57:21,719 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-22 18:57:21,719 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-22 18:57:21,720 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-22 18:57:21,720 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-22 18:57:21,721 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-22 18:57:21,721 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-22 18:57:21,721 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-22 18:57:21,722 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-22 18:57:21,723 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-22 18:57:21,723 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-22 18:57:21,723 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-22 18:57:21,724 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-22 18:57:21,724 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-22 18:57:21,725 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-22 18:57:21,725 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-22 18:57:21,725 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-22 18:57:21,726 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-09-22 18:57:21,726 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-22 18:57:21,726 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-22 18:57:21,737 [salt.utils.extmods][INFO    ][23686] Syncing states for environment 'base'
2017-09-22 18:57:21,737 [salt.utils.extmods][INFO    ][23686] Loading cache from salt://_states, for base)
2017-09-22 18:57:21,738 [salt.fileclient  ][INFO    ][23686] Caching directory '_states/' for environment 'base'
2017-09-22 18:57:21,792 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-22 18:57:21,806 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-22 18:57:21,816 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-22 18:57:21,837 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-22 18:57:21,856 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-22 18:57:21,874 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-22 18:57:21,892 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-22 18:57:21,910 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-22 18:57:21,937 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-22 18:57:21,947 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-22 18:57:21,964 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-22 18:57:21,975 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-22 18:57:21,988 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-22 18:57:21,999 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-22 18:57:22,012 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-22 18:57:22,025 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-22 18:57:22,035 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-22 18:57:22,056 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-22 18:57:22,084 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-22 18:57:22,114 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-22 18:57:22,205 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-22 18:57:22,219 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-22 18:57:22,285 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-22 18:57:22,312 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-22 18:57:22,328 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-22 18:57:22,340 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-22 18:57:22,399 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-22 18:57:22,432 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-22 18:57:22,448 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-22 18:57:22,454 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-22 18:57:22,454 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-22 18:57:22,455 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-22 18:57:22,456 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-22 18:57:22,456 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-22 18:57:22,457 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-22 18:57:22,457 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-22 18:57:22,458 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-22 18:57:22,458 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-22 18:57:22,458 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-22 18:57:22,459 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-22 18:57:22,459 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-22 18:57:22,478 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-22 18:57:22,478 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-22 18:57:22,478 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-22 18:57:22,479 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-22 18:57:22,479 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-22 18:57:22,480 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-22 18:57:22,480 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-22 18:57:22,481 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-22 18:57:22,481 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-22 18:57:22,481 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-22 18:57:22,482 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-22 18:57:22,482 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-22 18:57:22,483 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-22 18:57:22,483 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-22 18:57:22,484 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-22 18:57:22,484 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-22 18:57:22,484 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-22 18:57:22,485 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-22 18:57:22,487 [salt.utils.extmods][INFO    ][23686] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-22 18:57:22,492 [salt.utils.extmods][INFO    ][23686] Syncing sdb for environment 'base'
2017-09-22 18:57:22,492 [salt.utils.extmods][INFO    ][23686] Loading cache from salt://_sdb, for base)
2017-09-22 18:57:22,492 [salt.fileclient  ][INFO    ][23686] Caching directory '_sdb/' for environment 'base'
2017-09-22 18:57:22,535 [salt.utils.extmods][INFO    ][23686] Syncing grains for environment 'base'
2017-09-22 18:57:22,536 [salt.utils.extmods][INFO    ][23686] Loading cache from salt://_grains, for base)
2017-09-22 18:57:22,536 [salt.fileclient  ][INFO    ][23686] Caching directory '_grains/' for environment 'base'
2017-09-22 18:57:22,580 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-22 18:57:22,590 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-22 18:57:22,614 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-22 18:57:22,625 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-22 18:57:22,637 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-22 18:57:22,649 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-22 18:57:22,658 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-22 18:57:22,667 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-22 18:57:22,676 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-22 18:57:22,930 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-22 18:57:22,940 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-22 18:57:22,947 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-22 18:57:22,948 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-22 18:57:22,948 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-22 18:57:22,949 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-22 18:57:22,949 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-22 18:57:22,950 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-22 18:57:22,950 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-22 18:57:22,950 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-22 18:57:22,951 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-22 18:57:22,951 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-22 18:57:22,952 [salt.utils.extmods][INFO    ][23686] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-22 18:57:22,954 [salt.utils.extmods][INFO    ][23686] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-22 18:57:22,960 [salt.utils.extmods][INFO    ][23686] Syncing renderers for environment 'base'
2017-09-22 18:57:22,960 [salt.utils.extmods][INFO    ][23686] Loading cache from salt://_renderers, for base)
2017-09-22 18:57:22,960 [salt.fileclient  ][INFO    ][23686] Caching directory '_renderers/' for environment 'base'
2017-09-22 18:57:22,990 [salt.utils.extmods][INFO    ][23686] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-22 18:57:22,994 [salt.utils.extmods][INFO    ][23686] Syncing returners for environment 'base'
2017-09-22 18:57:22,995 [salt.utils.extmods][INFO    ][23686] Loading cache from salt://_returners, for base)
2017-09-22 18:57:22,995 [salt.fileclient  ][INFO    ][23686] Caching directory '_returners/' for environment 'base'
2017-09-22 18:57:23,021 [salt.utils.extmods][INFO    ][23686] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-22 18:57:23,025 [salt.utils.extmods][INFO    ][23686] Syncing output for environment 'base'
2017-09-22 18:57:23,025 [salt.utils.extmods][INFO    ][23686] Loading cache from salt://_output, for base)
2017-09-22 18:57:23,026 [salt.fileclient  ][INFO    ][23686] Caching directory '_output/' for environment 'base'
2017-09-22 18:57:23,050 [salt.utils.extmods][INFO    ][23686] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-22 18:57:23,055 [salt.utils.extmods][INFO    ][23686] Syncing utils for environment 'base'
2017-09-22 18:57:23,055 [salt.utils.extmods][INFO    ][23686] Loading cache from salt://_utils, for base)
2017-09-22 18:57:23,055 [salt.fileclient  ][INFO    ][23686] Caching directory '_utils/' for environment 'base'
2017-09-22 18:57:23,323 [salt.utils.extmods][INFO    ][23686] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-22 18:57:23,328 [salt.utils.extmods][INFO    ][23686] Syncing log_handlers for environment 'base'
2017-09-22 18:57:23,328 [salt.utils.extmods][INFO    ][23686] Loading cache from salt://_log_handlers, for base)
2017-09-22 18:57:23,328 [salt.fileclient  ][INFO    ][23686] Caching directory '_log_handlers/' for environment 'base'
2017-09-22 18:57:23,356 [salt.utils.extmods][INFO    ][23686] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-22 18:57:23,361 [salt.utils.extmods][INFO    ][23686] Syncing proxy for environment 'base'
2017-09-22 18:57:23,362 [salt.utils.extmods][INFO    ][23686] Loading cache from salt://_proxy, for base)
2017-09-22 18:57:23,362 [salt.fileclient  ][INFO    ][23686] Caching directory '_proxy/' for environment 'base'
2017-09-22 18:57:23,391 [salt.utils.extmods][INFO    ][23686] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-22 18:57:23,396 [salt.utils.extmods][INFO    ][23686] Syncing engines for environment 'base'
2017-09-22 18:57:23,396 [salt.utils.extmods][INFO    ][23686] Loading cache from salt://_engines, for base)
2017-09-22 18:57:23,396 [salt.fileclient  ][INFO    ][23686] Caching directory '_engines/' for environment 'base'
2017-09-22 18:57:23,426 [salt.minion      ][INFO    ][23686] Returning information for job: 20170922185717061874
2017-09-22 19:02:53,181 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command pkg.upgrade with jid 20170922190253166812
2017-09-22 19:02:53,203 [salt.minion      ][INFO    ][23860] Starting a new job with PID 23860
2017-09-22 19:02:53,231 [salt.loaded.int.module.cmdmod][INFO    ][23860] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-22 19:02:53,656 [salt.loaded.int.module.cmdmod][INFO    ][23860] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-09-22 19:03:03,257 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190303242224
2017-09-22 19:03:03,283 [salt.minion      ][INFO    ][24000] Starting a new job with PID 24000
2017-09-22 19:03:03,303 [salt.minion      ][INFO    ][24000] Returning information for job: 20170922190303242224
2017-09-22 19:03:13,480 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190313465951
2017-09-22 19:03:13,502 [salt.minion      ][INFO    ][24048] Starting a new job with PID 24048
2017-09-22 19:03:13,520 [salt.minion      ][INFO    ][24048] Returning information for job: 20170922190313465951
2017-09-22 19:03:23,566 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190323551675
2017-09-22 19:03:23,589 [salt.minion      ][INFO    ][24632] Starting a new job with PID 24632
2017-09-22 19:03:23,611 [salt.minion      ][INFO    ][24632] Returning information for job: 20170922190323551675
2017-09-22 19:03:33,586 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190333571800
2017-09-22 19:03:33,607 [salt.minion      ][INFO    ][24733] Starting a new job with PID 24733
2017-09-22 19:03:33,684 [salt.minion      ][INFO    ][24733] Returning information for job: 20170922190333571800
2017-09-22 19:03:43,763 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190343738057
2017-09-22 19:03:43,784 [salt.minion      ][INFO    ][24976] Starting a new job with PID 24976
2017-09-22 19:03:43,803 [salt.minion      ][INFO    ][24976] Returning information for job: 20170922190343738057
2017-09-22 19:03:53,822 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190353806831
2017-09-22 19:03:53,844 [salt.minion      ][INFO    ][25211] Starting a new job with PID 25211
2017-09-22 19:03:53,907 [salt.minion      ][INFO    ][25211] Returning information for job: 20170922190353806831
2017-09-22 19:04:04,034 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190404019381
2017-09-22 19:04:04,055 [salt.minion      ][INFO    ][25563] Starting a new job with PID 25563
2017-09-22 19:04:04,076 [salt.minion      ][INFO    ][25563] Returning information for job: 20170922190404019381
2017-09-22 19:04:14,223 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190414208581
2017-09-22 19:04:14,247 [salt.minion      ][INFO    ][25837] Starting a new job with PID 25837
2017-09-22 19:04:14,338 [salt.minion      ][INFO    ][25837] Returning information for job: 20170922190414208581
2017-09-22 19:04:24,335 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190424320890
2017-09-22 19:04:24,354 [salt.minion      ][INFO    ][26054] Starting a new job with PID 26054
2017-09-22 19:04:24,386 [salt.minion      ][INFO    ][26054] Returning information for job: 20170922190424320890
2017-09-22 19:04:34,424 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190434409686
2017-09-22 19:04:34,449 [salt.minion      ][INFO    ][26286] Starting a new job with PID 26286
2017-09-22 19:04:34,466 [salt.minion      ][INFO    ][26286] Returning information for job: 20170922190434409686
2017-09-22 19:04:44,603 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190444588956
2017-09-22 19:04:44,624 [salt.minion      ][INFO    ][26587] Starting a new job with PID 26587
2017-09-22 19:04:44,652 [salt.minion      ][INFO    ][26587] Returning information for job: 20170922190444588956
2017-09-22 19:04:54,719 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190454704538
2017-09-22 19:04:54,742 [salt.minion      ][INFO    ][28116] Starting a new job with PID 28116
2017-09-22 19:04:54,763 [salt.minion      ][INFO    ][28116] Returning information for job: 20170922190454704538
2017-09-22 19:05:04,744 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190504729986
2017-09-22 19:05:04,769 [salt.minion      ][INFO    ][30107] Starting a new job with PID 30107
2017-09-22 19:05:04,788 [salt.minion      ][INFO    ][30107] Returning information for job: 20170922190504729986
2017-09-22 19:05:14,827 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190514813900
2017-09-22 19:05:14,852 [salt.minion      ][INFO    ][31630] Starting a new job with PID 31630
2017-09-22 19:05:14,877 [salt.minion      ][INFO    ][31630] Returning information for job: 20170922190514813900
2017-09-22 19:05:17,399 [salt.loaded.int.module.cmdmod][INFO    ][23860] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-22 19:05:17,444 [salt.minion      ][INFO    ][23860] Returning information for job: 20170922190253166812
2017-09-22 19:06:57,576 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command test.ping with jid 20170922190657563629
2017-09-22 19:06:57,598 [salt.minion      ][INFO    ][31717] Starting a new job with PID 31717
2017-09-22 19:06:57,655 [salt.minion      ][INFO    ][31717] Returning information for job: 20170922190657563629
2017-09-22 19:09:19,268 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command state.sls with jid 20170922190919255706
2017-09-22 19:09:19,290 [salt.minion      ][INFO    ][31742] Starting a new job with PID 31742
2017-09-22 19:09:20,871 [salt.state       ][INFO    ][31742] Loading fresh modules for state activity
2017-09-22 19:09:20,986 [salt.fileclient  ][INFO    ][31742] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-22 19:09:21,013 [salt.fileclient  ][INFO    ][31742] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-22 19:09:21,054 [salt.fileclient  ][INFO    ][31742] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-22 19:09:21,529 [salt.state       ][INFO    ][31742] Running state [lsof] at time 19:09:21.529355
2017-09-22 19:09:21,530 [salt.state       ][INFO    ][31742] Executing state pkg.installed for lsof
2017-09-22 19:09:21,530 [salt.loaded.int.module.cmdmod][INFO    ][31742] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-22 19:09:21,900 [salt.state       ][INFO    ][31742] Package lsof is already installed
2017-09-22 19:09:21,901 [salt.state       ][INFO    ][31742] Completed state [lsof] at time 19:09:21.901171 duration_in_ms=371.814
2017-09-22 19:09:21,902 [salt.state       ][INFO    ][31742] Running state [keepalived] at time 19:09:21.901943
2017-09-22 19:09:21,903 [salt.state       ][INFO    ][31742] Executing state pkg.installed for keepalived
2017-09-22 19:09:21,937 [salt.loaded.int.module.cmdmod][INFO    ][31742] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-22 19:09:24,125 [salt.loaded.int.module.cmdmod][INFO    ][31742] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-09-22 19:09:29,314 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922190929300622
2017-09-22 19:09:29,335 [salt.minion      ][INFO    ][473] Starting a new job with PID 473
2017-09-22 19:09:29,365 [salt.minion      ][INFO    ][473] Returning information for job: 20170922190929300622
2017-09-22 19:09:33,547 [salt.loaded.int.module.cmdmod][INFO    ][31742] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-22 19:09:33,598 [salt.state       ][INFO    ][31742] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-09-22 19:09:33,629 [salt.state       ][INFO    ][31742] Loading fresh modules for state activity
2017-09-22 19:09:33,662 [salt.state       ][INFO    ][31742] Completed state [keepalived] at time 19:09:33.661636 duration_in_ms=11759.692
2017-09-22 19:09:33,667 [salt.state       ][INFO    ][31742] Running state [/etc/keepalived/keepalived.conf] at time 19:09:33.666979
2017-09-22 19:09:33,667 [salt.state       ][INFO    ][31742] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-22 19:09:33,702 [salt.fileclient  ][INFO    ][31742] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-22 19:09:33,750 [salt.fileclient  ][INFO    ][31742] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-22 19:09:33,761 [salt.state       ][INFO    ][31742] File changed:
New file
2017-09-22 19:09:33,761 [salt.state       ][INFO    ][31742] Completed state [/etc/keepalived/keepalived.conf] at time 19:09:33.761333 duration_in_ms=94.354
2017-09-22 19:09:33,858 [salt.state       ][INFO    ][31742] Running state [keepalived] at time 19:09:33.857718
2017-09-22 19:09:33,858 [salt.state       ][INFO    ][31742] Executing state service.running for keepalived
2017-09-22 19:09:33,860 [salt.loaded.int.module.cmdmod][INFO    ][31742] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-22 19:09:33,877 [salt.loaded.int.module.cmdmod][INFO    ][31742] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-22 19:09:33,891 [salt.loaded.int.module.cmdmod][INFO    ][31742] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-22 19:09:33,906 [salt.loaded.int.module.cmdmod][INFO    ][31742] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-22 19:09:33,921 [salt.loaded.int.module.cmdmod][INFO    ][31742] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-22 19:09:34,007 [salt.loaded.int.module.cmdmod][INFO    ][31742] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-22 19:09:34,021 [salt.loaded.int.module.cmdmod][INFO    ][31742] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-22 19:09:34,033 [salt.loaded.int.module.cmdmod][INFO    ][31742] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-22 19:09:34,046 [salt.state       ][INFO    ][31742] {'keepalived': True}
2017-09-22 19:09:34,046 [salt.state       ][INFO    ][31742] Completed state [keepalived] at time 19:09:34.045999 duration_in_ms=188.28
2017-09-22 19:09:34,048 [salt.minion      ][INFO    ][31742] Returning information for job: 20170922190919255706
2017-09-22 19:09:34,865 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command pillar.get with jid 20170922190934857740
2017-09-22 19:09:34,889 [salt.minion      ][INFO    ][782] Starting a new job with PID 782
2017-09-22 19:09:34,896 [salt.minion      ][INFO    ][782] Returning information for job: 20170922190934857740
2017-09-22 19:15:09,225 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command state.sls with jid 20170922191509212285
2017-09-22 19:15:09,246 [salt.minion      ][INFO    ][879] Starting a new job with PID 879
2017-09-22 19:15:11,780 [salt.state       ][INFO    ][879] Loading fresh modules for state activity
2017-09-22 19:15:11,822 [salt.fileclient  ][INFO    ][879] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-22 19:15:11,856 [salt.fileclient  ][INFO    ][879] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-22 19:15:12,215 [salt.state       ][INFO    ][879] Running state [attr] at time 19:15:12.215335
2017-09-22 19:15:12,216 [salt.state       ][INFO    ][879] Executing state pkg.installed for attr
2017-09-22 19:15:12,216 [salt.loaded.int.module.cmdmod][INFO    ][879] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-22 19:15:12,536 [salt.loaded.int.module.cmdmod][INFO    ][879] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-22 19:15:14,842 [salt.loaded.int.module.cmdmod][INFO    ][879] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-09-22 19:15:17,950 [salt.loaded.int.module.cmdmod][INFO    ][879] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-22 19:15:18,004 [salt.state       ][INFO    ][879] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-22 19:15:18,021 [salt.state       ][INFO    ][879] Loading fresh modules for state activity
2017-09-22 19:15:18,045 [salt.state       ][INFO    ][879] Completed state [attr] at time 19:15:18.045302 duration_in_ms=5829.966
2017-09-22 19:15:18,055 [salt.state       ][INFO    ][879] Running state [glusterfs-server] at time 19:15:18.054466
2017-09-22 19:15:18,055 [salt.state       ][INFO    ][879] Executing state pkg.installed for glusterfs-server
2017-09-22 19:15:18,323 [salt.loaded.int.module.cmdmod][INFO    ][879] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-09-22 19:15:19,319 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922191519305048
2017-09-22 19:15:19,339 [salt.minion      ][INFO    ][1882] Starting a new job with PID 1882
2017-09-22 19:15:19,359 [salt.minion      ][INFO    ][1882] Returning information for job: 20170922191519305048
2017-09-22 19:15:29,525 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922191529511808
2017-09-22 19:15:29,546 [salt.minion      ][INFO    ][4611] Starting a new job with PID 4611
2017-09-22 19:15:29,565 [salt.minion      ][INFO    ][4611] Returning information for job: 20170922191529511808
2017-09-22 19:15:39,751 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command saltutil.find_job with jid 20170922191539738505
2017-09-22 19:15:39,772 [salt.minion      ][INFO    ][5212] Starting a new job with PID 5212
2017-09-22 19:15:39,791 [salt.minion      ][INFO    ][5212] Returning information for job: 20170922191539738505
2017-09-22 19:15:40,753 [salt.loaded.int.module.cmdmod][INFO    ][879] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-22 19:15:40,810 [salt.state       ][INFO    ][879] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-09-22 19:15:40,829 [salt.state       ][INFO    ][879] Loading fresh modules for state activity
2017-09-22 19:15:40,855 [salt.state       ][INFO    ][879] Completed state [glusterfs-server] at time 19:15:40.855318 duration_in_ms=22800.852
2017-09-22 19:15:40,864 [salt.state       ][INFO    ][879] Running state [bc] at time 19:15:40.864096
2017-09-22 19:15:40,864 [salt.state       ][INFO    ][879] Executing state pkg.installed for bc
2017-09-22 19:15:41,220 [salt.loaded.int.module.cmdmod][INFO    ][879] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-09-22 19:15:44,653 [salt.loaded.int.module.cmdmod][INFO    ][879] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-22 19:15:44,707 [salt.state       ][INFO    ][879] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-22 19:15:44,723 [salt.state       ][INFO    ][879] Loading fresh modules for state activity
2017-09-22 19:15:44,745 [salt.state       ][INFO    ][879] Completed state [bc] at time 19:15:44.745361 duration_in_ms=3881.265
2017-09-22 19:15:44,841 [salt.state       ][INFO    ][879] Running state [glusterfs-server] at time 19:15:44.841341
2017-09-22 19:15:44,842 [salt.state       ][INFO    ][879] Executing state service.running for glusterfs-server
2017-09-22 19:15:44,843 [salt.loaded.int.module.cmdmod][INFO    ][879] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-22 19:15:44,860 [salt.loaded.int.module.cmdmod][INFO    ][879] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-22 19:15:44,873 [salt.loaded.int.module.cmdmod][INFO    ][879] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-22 19:15:44,890 [salt.state       ][INFO    ][879] The service glusterfs-server is already running
2017-09-22 19:15:44,890 [salt.state       ][INFO    ][879] Completed state [glusterfs-server] at time 19:15:44.890038 duration_in_ms=48.696
2017-09-22 19:15:44,892 [salt.state       ][INFO    ][879] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 19:15:44.891915
2017-09-22 19:15:44,892 [salt.state       ][INFO    ][879] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-22 19:15:44,910 [salt.state       ][INFO    ][879] File changed:
New file
2017-09-22 19:15:44,910 [salt.state       ][INFO    ][879] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 19:15:44.910295 duration_in_ms=18.38
2017-09-22 19:15:44,911 [salt.state       ][INFO    ][879] Running state [/srv/glusterfs/glance] at time 19:15:44.910513
2017-09-22 19:15:44,911 [salt.state       ][INFO    ][879] Executing state file.directory for /srv/glusterfs/glance
2017-09-22 19:15:44,912 [salt.state       ][INFO    ][879] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-22 19:15:44,912 [salt.state       ][INFO    ][879] Completed state [/srv/glusterfs/glance] at time 19:15:44.911710 duration_in_ms=1.197
2017-09-22 19:15:44,912 [salt.state       ][INFO    ][879] Running state [/srv/glusterfs/keystone-keys] at time 19:15:44.911928
2017-09-22 19:15:44,912 [salt.state       ][INFO    ][879] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-22 19:15:44,913 [salt.state       ][INFO    ][879] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-22 19:15:44,913 [salt.state       ][INFO    ][879] Completed state [/srv/glusterfs/keystone-keys] at time 19:15:44.912860 duration_in_ms=0.932
2017-09-22 19:15:44,913 [salt.state       ][INFO    ][879] Running state [/srv/glusterfs/nova_instances] at time 19:15:44.913084
2017-09-22 19:15:44,913 [salt.state       ][INFO    ][879] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-22 19:15:44,914 [salt.state       ][INFO    ][879] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-22 19:15:44,914 [salt.state       ][INFO    ][879] Completed state [/srv/glusterfs/nova_instances] at time 19:15:44.914047 duration_in_ms=0.963
2017-09-22 19:15:44,914 [salt.state       ][INFO    ][879] Running state [/srv/glusterfs/keystone-credential-keys] at time 19:15:44.914262
2017-09-22 19:15:44,914 [salt.state       ][INFO    ][879] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-22 19:15:44,915 [salt.state       ][INFO    ][879] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-22 19:15:44,915 [salt.state       ][INFO    ][879] Completed state [/srv/glusterfs/keystone-credential-keys] at time 19:15:44.915196 duration_in_ms=0.934
2017-09-22 19:15:44,916 [salt.minion      ][INFO    ][879] Returning information for job: 20170922191509212285
2017-09-22 19:15:46,060 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command test.ping with jid 20170922191546047170
2017-09-22 19:15:46,079 [salt.minion      ][INFO    ][5690] Starting a new job with PID 5690
2017-09-22 19:15:46,132 [salt.minion      ][INFO    ][5690] Returning information for job: 20170922191546047170
2017-09-22 19:16:32,152 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command state.sls with jid 20170922191632139874
2017-09-22 19:16:32,172 [salt.minion      ][INFO    ][5911] Starting a new job with PID 5911
2017-09-22 19:16:32,631 [salt.state       ][INFO    ][5911] Loading fresh modules for state activity
2017-09-22 19:16:32,669 [salt.fileclient  ][INFO    ][5911] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-22 19:16:32,722 [salt.fileclient  ][INFO    ][5911] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-22 19:16:32,818 [salt.fileclient  ][INFO    ][5911] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-22 19:16:32,840 [salt.fileclient  ][INFO    ][5911] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-22 19:16:33,135 [salt.state       ][INFO    ][5911] Running state [attr] at time 19:16:33.134471
2017-09-22 19:16:33,135 [salt.state       ][INFO    ][5911] Executing state pkg.installed for attr
2017-09-22 19:16:33,135 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-22 19:16:33,500 [salt.state       ][INFO    ][5911] Package attr is already installed
2017-09-22 19:16:33,500 [salt.state       ][INFO    ][5911] Completed state [attr] at time 19:16:33.500090 duration_in_ms=365.619
2017-09-22 19:16:33,500 [salt.state       ][INFO    ][5911] Running state [glusterfs-server] at time 19:16:33.500301
2017-09-22 19:16:33,501 [salt.state       ][INFO    ][5911] Executing state pkg.installed for glusterfs-server
2017-09-22 19:16:33,503 [salt.state       ][INFO    ][5911] Package glusterfs-server is already installed
2017-09-22 19:16:33,503 [salt.state       ][INFO    ][5911] Completed state [glusterfs-server] at time 19:16:33.503324 duration_in_ms=3.023
2017-09-22 19:16:33,504 [salt.state       ][INFO    ][5911] Running state [bc] at time 19:16:33.503478
2017-09-22 19:16:33,504 [salt.state       ][INFO    ][5911] Executing state pkg.installed for bc
2017-09-22 19:16:33,506 [salt.state       ][INFO    ][5911] Package bc is already installed
2017-09-22 19:16:33,506 [salt.state       ][INFO    ][5911] Completed state [bc] at time 19:16:33.506402 duration_in_ms=2.925
2017-09-22 19:16:33,507 [salt.state       ][INFO    ][5911] Running state [glusterfs-server] at time 19:16:33.507237
2017-09-22 19:16:33,507 [salt.state       ][INFO    ][5911] Executing state service.running for glusterfs-server
2017-09-22 19:16:33,508 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-22 19:16:33,525 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-22 19:16:33,612 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-22 19:16:33,635 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-22 19:16:33,648 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-22 19:16:33,666 [salt.state       ][INFO    ][5911] The service glusterfs-server is already running
2017-09-22 19:16:33,666 [salt.state       ][INFO    ][5911] Completed state [glusterfs-server] at time 19:16:33.665886 duration_in_ms=158.648
2017-09-22 19:16:33,668 [salt.state       ][INFO    ][5911] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 19:16:33.667840
2017-09-22 19:16:33,668 [salt.state       ][INFO    ][5911] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-22 19:16:33,677 [salt.state       ][INFO    ][5911] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-22 19:16:33,677 [salt.state       ][INFO    ][5911] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 19:16:33.676957 duration_in_ms=9.121
2017-09-22 19:16:33,677 [salt.state       ][INFO    ][5911] Running state [/srv/glusterfs/glance] at time 19:16:33.677203
2017-09-22 19:16:33,677 [salt.state       ][INFO    ][5911] Executing state file.directory for /srv/glusterfs/glance
2017-09-22 19:16:33,678 [salt.state       ][INFO    ][5911] Directory /srv/glusterfs/glance is in the correct state
2017-09-22 19:16:33,678 [salt.state       ][INFO    ][5911] Completed state [/srv/glusterfs/glance] at time 19:16:33.678089 duration_in_ms=0.886
2017-09-22 19:16:33,678 [salt.state       ][INFO    ][5911] Running state [/srv/glusterfs/keystone-keys] at time 19:16:33.678306
2017-09-22 19:16:33,679 [salt.state       ][INFO    ][5911] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-22 19:16:33,679 [salt.state       ][INFO    ][5911] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-22 19:16:33,679 [salt.state       ][INFO    ][5911] Completed state [/srv/glusterfs/keystone-keys] at time 19:16:33.679163 duration_in_ms=0.857
2017-09-22 19:16:33,679 [salt.state       ][INFO    ][5911] Running state [/srv/glusterfs/nova_instances] at time 19:16:33.679380
2017-09-22 19:16:33,680 [salt.state       ][INFO    ][5911] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-22 19:16:33,680 [salt.state       ][INFO    ][5911] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-22 19:16:33,680 [salt.state       ][INFO    ][5911] Completed state [/srv/glusterfs/nova_instances] at time 19:16:33.680232 duration_in_ms=0.852
2017-09-22 19:16:33,680 [salt.state       ][INFO    ][5911] Running state [/srv/glusterfs/keystone-credential-keys] at time 19:16:33.680451
2017-09-22 19:16:33,681 [salt.state       ][INFO    ][5911] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-22 19:16:33,681 [salt.state       ][INFO    ][5911] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-22 19:16:33,681 [salt.state       ][INFO    ][5911] Completed state [/srv/glusterfs/keystone-credential-keys] at time 19:16:33.681341 duration_in_ms=0.89
2017-09-22 19:16:33,749 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command ['git', '--version'] in directory '/root'
2017-09-22 19:16:33,874 [salt.state       ][INFO    ][5911] Running state [sleep 5] at time 19:16:33.874002
2017-09-22 19:16:33,875 [salt.state       ][INFO    ][5911] Executing state cmd.wait for sleep 5
2017-09-22 19:16:33,876 [salt.state       ][INFO    ][5911] No changes made for sleep 5
2017-09-22 19:16:33,876 [salt.state       ][INFO    ][5911] Completed state [sleep 5] at time 19:16:33.875897 duration_in_ms=1.896
2017-09-22 19:16:33,877 [salt.state       ][INFO    ][5911] Running state [10.167.4.141] at time 19:16:33.876672
2017-09-22 19:16:33,877 [salt.state       ][INFO    ][5911] Executing state glusterfs.peered for 10.167.4.141
2017-09-22 19:16:33,878 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:33,897 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:33,982 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:33,999 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:34,100 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:34,115 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:34,218 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:34,235 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:34,338 [salt.state       ][INFO    ][5911] Peering with localhost is not needed
2017-09-22 19:16:34,339 [salt.state       ][INFO    ][5911] Completed state [10.167.4.141] at time 19:16:34.338729 duration_in_ms=462.055
2017-09-22 19:16:34,345 [salt.state       ][INFO    ][5911] Running state [10.167.4.142] at time 19:16:34.344683
2017-09-22 19:16:34,345 [salt.state       ][INFO    ][5911] Executing state glusterfs.peered for 10.167.4.142
2017-09-22 19:16:34,346 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:34,364 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:34,465 [salt.state       ][INFO    ][5911] Host 10.167.4.142 already peered
2017-09-22 19:16:34,466 [salt.state       ][INFO    ][5911] Completed state [10.167.4.142] at time 19:16:34.465717 duration_in_ms=121.033
2017-09-22 19:16:34,472 [salt.state       ][INFO    ][5911] Running state [10.167.4.143] at time 19:16:34.471908
2017-09-22 19:16:34,473 [salt.state       ][INFO    ][5911] Executing state glusterfs.peered for 10.167.4.143
2017-09-22 19:16:34,474 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:34,489 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:34,580 [salt.state       ][INFO    ][5911] Host 10.167.4.143 already peered
2017-09-22 19:16:34,581 [salt.state       ][INFO    ][5911] Completed state [10.167.4.143] at time 19:16:34.580685 duration_in_ms=108.777
2017-09-22 19:16:34,583 [salt.state       ][INFO    ][5911] Running state [glance] at time 19:16:34.582767
2017-09-22 19:16:34,583 [salt.state       ][INFO    ][5911] Executing state glusterfs.created for glance
2017-09-22 19:16:34,584 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:34,602 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:34,706 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:34,724 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:34,863 [salt.state       ][INFO    ][5911] Volume glance already exists and is started.
2017-09-22 19:16:34,864 [salt.state       ][INFO    ][5911] Completed state [glance] at time 19:16:34.863836 duration_in_ms=281.068
2017-09-22 19:16:34,871 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 19:16:34.871365
2017-09-22 19:16:34,872 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-22 19:16:34,873 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-22 19:16:34,972 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:34,973 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 19:16:34.972813 duration_in_ms=101.445
2017-09-22 19:16:34,974 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 19:16:34.973920
2017-09-22 19:16:34,975 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-22 19:16:34,976 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-22 19:16:35,079 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:35,080 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 19:16:35.079909 duration_in_ms=105.988
2017-09-22 19:16:35,081 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 19:16:35.080912
2017-09-22 19:16:35,081 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-22 19:16:35,082 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-22 19:16:35,184 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:35,185 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 19:16:35.184553 duration_in_ms=103.64
2017-09-22 19:16:35,186 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 19:16:35.185718
2017-09-22 19:16:35,186 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-22 19:16:35,187 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-22 19:16:35,296 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:35,297 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 19:16:35.296861 duration_in_ms=111.143
2017-09-22 19:16:35,298 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 19:16:35.297889
2017-09-22 19:16:35,298 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-22 19:16:35,299 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-22 19:16:35,400 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:35,401 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 19:16:35.400770 duration_in_ms=102.879
2017-09-22 19:16:35,403 [salt.state       ][INFO    ][5911] Running state [glance] at time 19:16:35.403421
2017-09-22 19:16:35,404 [salt.state       ][INFO    ][5911] Executing state glusterfs.started for glance
2017-09-22 19:16:35,405 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:35,423 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:35,527 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:35,545 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:35,779 [salt.state       ][INFO    ][5911] Volume glance is already started
2017-09-22 19:16:35,780 [salt.state       ][INFO    ][5911] Completed state [glance] at time 19:16:35.779448 duration_in_ms=376.027
2017-09-22 19:16:35,781 [salt.state       ][INFO    ][5911] Running state [keystone-keys] at time 19:16:35.780577
2017-09-22 19:16:35,781 [salt.state       ][INFO    ][5911] Executing state glusterfs.created for keystone-keys
2017-09-22 19:16:35,782 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:35,800 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:35,903 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:35,921 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:36,031 [salt.state       ][INFO    ][5911] Volume keystone-keys already exists and is started.
2017-09-22 19:16:36,031 [salt.state       ][INFO    ][5911] Completed state [keystone-keys] at time 19:16:36.031296 duration_in_ms=250.716
2017-09-22 19:16:36,040 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 19:16:36.039634
2017-09-22 19:16:36,040 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-22 19:16:36,041 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-22 19:16:36,145 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:36,145 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 19:16:36.145373 duration_in_ms=105.739
2017-09-22 19:16:36,146 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 19:16:36.146418
2017-09-22 19:16:36,147 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-22 19:16:36,148 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-22 19:16:36,251 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:36,252 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 19:16:36.251979 duration_in_ms=105.56
2017-09-22 19:16:36,253 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 19:16:36.253078
2017-09-22 19:16:36,254 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-22 19:16:36,255 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-22 19:16:36,359 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:36,359 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 19:16:36.359105 duration_in_ms=106.027
2017-09-22 19:16:36,360 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 19:16:36.360097
2017-09-22 19:16:36,361 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-22 19:16:36,362 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-22 19:16:36,471 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:36,472 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 19:16:36.471453 duration_in_ms=111.355
2017-09-22 19:16:36,473 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 19:16:36.472557
2017-09-22 19:16:36,473 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-22 19:16:36,474 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-22 19:16:36,579 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:36,580 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 19:16:36.579607 duration_in_ms=107.049
2017-09-22 19:16:36,582 [salt.state       ][INFO    ][5911] Running state [keystone-keys] at time 19:16:36.582286
2017-09-22 19:16:36,583 [salt.state       ][INFO    ][5911] Executing state glusterfs.started for keystone-keys
2017-09-22 19:16:36,584 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:36,601 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:36,685 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:36,703 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:36,814 [salt.state       ][INFO    ][5911] Volume keystone-keys is already started
2017-09-22 19:16:36,814 [salt.state       ][INFO    ][5911] Completed state [keystone-keys] at time 19:16:36.813991 duration_in_ms=231.704
2017-09-22 19:16:36,816 [salt.state       ][INFO    ][5911] Running state [nova_instances] at time 19:16:36.815877
2017-09-22 19:16:36,816 [salt.state       ][INFO    ][5911] Executing state glusterfs.created for nova_instances
2017-09-22 19:16:36,817 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:36,835 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:36,939 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:36,958 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:37,068 [salt.state       ][INFO    ][5911] Volume nova_instances already exists and is started.
2017-09-22 19:16:37,069 [salt.state       ][INFO    ][5911] Completed state [nova_instances] at time 19:16:37.068671 duration_in_ms=252.793
2017-09-22 19:16:37,077 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 19:16:37.076478
2017-09-22 19:16:37,077 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-22 19:16:37,078 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-22 19:16:37,184 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:37,184 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 19:16:37.184158 duration_in_ms=107.68
2017-09-22 19:16:37,185 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 19:16:37.185278
2017-09-22 19:16:37,186 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-09-22 19:16:37,187 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-22 19:16:37,287 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:37,288 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 19:16:37.287722 duration_in_ms=102.444
2017-09-22 19:16:37,289 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 19:16:37.288740
2017-09-22 19:16:37,289 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-09-22 19:16:37,290 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-22 19:16:37,399 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:37,399 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 19:16:37.399319 duration_in_ms=110.578
2017-09-22 19:16:37,400 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 19:16:37.400412
2017-09-22 19:16:37,401 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-09-22 19:16:37,402 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-09-22 19:16:37,509 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:37,510 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 19:16:37.509514 duration_in_ms=109.101
2017-09-22 19:16:37,511 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 19:16:37.510630
2017-09-22 19:16:37,511 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-22 19:16:37,512 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-22 19:16:37,622 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:37,622 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 19:16:37.622313 duration_in_ms=111.683
2017-09-22 19:16:37,625 [salt.state       ][INFO    ][5911] Running state [nova_instances] at time 19:16:37.624832
2017-09-22 19:16:37,625 [salt.state       ][INFO    ][5911] Executing state glusterfs.started for nova_instances
2017-09-22 19:16:37,626 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:37,644 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:37,749 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:37,765 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:37,871 [salt.state       ][INFO    ][5911] Volume nova_instances is already started
2017-09-22 19:16:37,872 [salt.state       ][INFO    ][5911] Completed state [nova_instances] at time 19:16:37.871888 duration_in_ms=247.055
2017-09-22 19:16:37,875 [salt.state       ][INFO    ][5911] Running state [keystone-credential-keys] at time 19:16:37.874417
2017-09-22 19:16:37,875 [salt.state       ][INFO    ][5911] Executing state glusterfs.created for keystone-credential-keys
2017-09-22 19:16:37,876 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:37,892 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:38,007 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:38,025 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:38,135 [salt.state       ][INFO    ][5911] Volume keystone-credential-keys already exists and is started.
2017-09-22 19:16:38,136 [salt.state       ][INFO    ][5911] Completed state [keystone-credential-keys] at time 19:16:38.135631 duration_in_ms=261.214
2017-09-22 19:16:38,144 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 19:16:38.143949
2017-09-22 19:16:38,145 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-22 19:16:38,146 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-22 19:16:38,247 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:38,247 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 19:16:38.247088 duration_in_ms=103.139
2017-09-22 19:16:38,248 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 19:16:38.248154
2017-09-22 19:16:38,249 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-22 19:16:38,250 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-22 19:16:38,352 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:38,353 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 19:16:38.352574 duration_in_ms=104.418
2017-09-22 19:16:38,354 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 19:16:38.353670
2017-09-22 19:16:38,354 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-22 19:16:38,355 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-22 19:16:38,459 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:38,459 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 19:16:38.459046 duration_in_ms=105.375
2017-09-22 19:16:38,460 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 19:16:38.460083
2017-09-22 19:16:38,461 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-22 19:16:38,462 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-22 19:16:38,563 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:38,563 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 19:16:38.563210 duration_in_ms=103.126
2017-09-22 19:16:38,564 [salt.state       ][INFO    ][5911] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 19:16:38.564006
2017-09-22 19:16:38,564 [salt.state       ][INFO    ][5911] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-22 19:16:38,565 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-22 19:16:38,664 [salt.state       ][INFO    ][5911] unless execution succeeded
2017-09-22 19:16:38,665 [salt.state       ][INFO    ][5911] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 19:16:38.664965 duration_in_ms=100.957
2017-09-22 19:16:38,668 [salt.state       ][INFO    ][5911] Running state [keystone-credential-keys] at time 19:16:38.667529
2017-09-22 19:16:38,668 [salt.state       ][INFO    ][5911] Executing state glusterfs.started for keystone-credential-keys
2017-09-22 19:16:38,669 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:38,683 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:38,788 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --version' in directory '/root'
2017-09-22 19:16:38,805 [salt.loaded.int.module.cmdmod][INFO    ][5911] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-22 19:16:38,918 [salt.state       ][INFO    ][5911] Volume keystone-credential-keys is already started
2017-09-22 19:16:38,919 [salt.state       ][INFO    ][5911] Completed state [keystone-credential-keys] at time 19:16:38.918589 duration_in_ms=251.059
2017-09-22 19:16:38,922 [salt.minion      ][INFO    ][5911] Returning information for job: 20170922191632139874
2017-09-22 19:16:40,123 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command test.ping with jid 20170922191640111718
2017-09-22 19:16:40,146 [salt.minion      ][INFO    ][6312] Starting a new job with PID 6312
2017-09-22 19:16:40,197 [salt.minion      ][INFO    ][6312] Returning information for job: 20170922191640111718
2017-09-22 19:16:40,838 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command cmd.run with jid 20170922191640826497
2017-09-22 19:16:40,861 [salt.minion      ][INFO    ][6317] Starting a new job with PID 6317
2017-09-22 19:16:40,867 [salt.loaded.int.module.cmdmod][INFO    ][6317] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-22 19:16:41,073 [salt.minion      ][INFO    ][6317] Returning information for job: 20170922191640826497
2017-09-22 19:55:08,567 [salt.utils.schedule][INFO    ][23524] Running scheduled job: __mine_interval
2017-09-22 20:38:58,301 [salt.minion      ][INFO    ][23524] User sudo_ubuntu Executing command cp.push_dir with jid 20170922203858286079
2017-09-22 20:38:58,324 [salt.minion      ][INFO    ][7557] Starting a new job with PID 7557
