2017-10-04 05:43:03,872 [salt.cli.daemons ][WARNING ][2539] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-04 05:58:18,435 [salt.state       ][ERROR   ][3843] No contents found in top file
2017-10-04 05:58:37,002 [salt.utils.parsers][WARNING ][2539] Minion received a SIGTERM. Exiting.
2017-10-04 06:00:49,608 [salt.cli.daemons ][WARNING ][3191] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-04 06:05:17,219 [salt.loaded.int.module.cmdmod][ERROR   ][10823] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-10-04 06:05:17,219 [salt.loaded.int.module.cmdmod][ERROR   ][10823] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-10-04 06:05:17,219 [salt.loaded.int.module.cmdmod][ERROR   ][10823] retcode: 1
2017-10-04 06:05:17,220 [salt.state       ][ERROR   ][10823] {'pid': 15632, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-10-04 06:05:36,645 [py.warnings      ][WARNING ][15673] /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-10-04 06:06:33,364 [salt.loaded.int.module.cmdmod][ERROR   ][15673] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-04 06:06:33,364 [salt.loaded.int.module.cmdmod][ERROR   ][15673] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-04 06:06:39,777 [salt.loaded.int.module.cmdmod][ERROR   ][15673] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-04 06:06:39,777 [salt.loaded.int.module.cmdmod][ERROR   ][15673] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-04 06:06:46,611 [salt.loaded.int.module.cmdmod][ERROR   ][15673] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-04 06:06:46,611 [salt.loaded.int.module.cmdmod][ERROR   ][15673] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-04 06:06:57,013 [salt.loaded.int.module.cmdmod][ERROR   ][15673] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-04 06:06:57,013 [salt.loaded.int.module.cmdmod][ERROR   ][15673] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-04 06:07:02,526 [salt.loaded.int.module.cmdmod][ERROR   ][15673] 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-10-04 06:07:04,702 [salt.loaded.int.module.cmdmod][INFO    ][22927] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-04 06:07:04,708 [salt.loaded.int.module.cmdmod][INFO    ][22927] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-04 06:07:04,716 [salt.loaded.int.module.cmdmod][INFO    ][22927] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-10-04 06:07:04,723 [salt.utils.parsers][WARNING ][3191] Minion received a SIGTERM. Exiting.
2017-10-04 06:07:04,976 [salt.cli.daemons ][INFO    ][23002] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-10-04 06:07:05,483 [salt.minion      ][INFO    ][23002] Creating minion process manager
2017-10-04 06:07:05,484 [salt.cli.daemons ][WARNING ][23002] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-04 06:07:05,484 [salt.cli.daemons ][INFO    ][23002] The Salt Minion is starting up
2017-10-04 06:07:05,484 [salt.minion      ][INFO    ][23002] Minion is starting as user 'root'
2017-10-04 06:07:05,485 [salt.utils.event ][INFO    ][23002] Starting pull socket on /var/run/salt/minion/minion_event_4fcafbd0f5_pull.ipc
2017-10-04 06:07:06,320 [salt.loaded.int.module.cmdmod][INFO    ][23002] Executing command ['date', '+%z'] in directory '/root'
2017-10-04 06:07:06,329 [salt.utils.schedule][INFO    ][23002] Updating job settings for scheduled job: __mine_interval
2017-10-04 06:07:06,331 [salt.minion      ][INFO    ][23002] Added mine.update to scheduler
2017-10-04 06:07:06,510 [salt.minion      ][INFO    ][23002] Minion is ready to receive requests!
2017-10-04 06:07:07,511 [salt.utils.schedule][INFO    ][23002] Running scheduled job: __mine_interval
2017-10-04 06:07:25,645 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171004060725637901
2017-10-04 06:07:25,660 [salt.minion      ][INFO    ][23109] Starting a new job with PID 23109
2017-10-04 06:07:27,250 [salt.state       ][INFO    ][23109] Loading fresh modules for state activity
2017-10-04 06:07:27,271 [salt.state       ][ERROR   ][23109] No contents found in top file
2017-10-04 06:07:27,271 [salt.utils.extmods][INFO    ][23109] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-04 06:07:27,274 [salt.utils.extmods][INFO    ][23109] Syncing beacons for environment 'base'
2017-10-04 06:07:27,274 [salt.utils.extmods][INFO    ][23109] Loading cache from salt://_beacons, for base)
2017-10-04 06:07:27,274 [salt.fileclient  ][INFO    ][23109] Caching directory '_beacons/' for environment 'base'
2017-10-04 06:07:27,310 [salt.utils.extmods][INFO    ][23109] Syncing modules for environment 'base'
2017-10-04 06:07:27,311 [salt.utils.extmods][INFO    ][23109] Loading cache from salt://_modules, for base)
2017-10-04 06:07:27,311 [salt.fileclient  ][INFO    ][23109] Caching directory '_modules/' for environment 'base'
2017-10-04 06:07:27,381 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-04 06:07:27,393 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-04 06:07:27,437 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-04 06:07:27,448 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-04 06:07:27,463 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-04 06:07:27,488 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-04 06:07:27,527 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-04 06:07:27,555 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-04 06:07:27,589 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-04 06:07:27,798 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-04 06:07:27,865 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-04 06:07:27,956 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-04 06:07:27,991 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-04 06:07:28,012 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-04 06:07:28,060 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-04 06:07:28,109 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-04 06:07:28,169 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-04 06:07:28,227 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-04 06:07:28,305 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-04 06:07:28,382 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-04 06:07:28,440 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-04 06:07:28,483 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-04 06:07:28,541 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-04 06:07:28,605 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-04 06:07:28,646 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-04 06:07:28,694 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-04 06:07:28,751 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-04 06:07:28,814 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-04 06:07:28,881 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-04 06:07:28,928 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-04 06:07:28,983 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-04 06:07:29,019 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-04 06:07:29,022 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-04 06:07:29,031 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-04 06:07:29,039 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-04 06:07:29,039 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-04 06:07:29,040 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-04 06:07:29,040 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-04 06:07:29,041 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-04 06:07:29,050 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-04 06:07:29,081 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-04 06:07:29,081 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-04 06:07:29,082 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-04 06:07:29,082 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-04 06:07:29,091 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-04 06:07:29,094 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-04 06:07:29,094 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-04 06:07:29,095 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-04 06:07:29,095 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-04 06:07:29,103 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-04 06:07:29,103 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-04 06:07:29,104 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-04 06:07:29,105 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-04 06:07:29,105 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-04 06:07:29,106 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-04 06:07:29,107 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-04 06:07:29,107 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-04 06:07:29,108 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-04 06:07:29,108 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-04 06:07:29,109 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-04 06:07:29,115 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-04 06:07:29,116 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-04 06:07:29,116 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-04 06:07:29,117 [salt.utils.extmods][INFO    ][23109] 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-10-04 06:07:29,117 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-04 06:07:29,117 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-04 06:07:29,122 [salt.utils.extmods][INFO    ][23109] Syncing states for environment 'base'
2017-10-04 06:07:29,122 [salt.utils.extmods][INFO    ][23109] Loading cache from salt://_states, for base)
2017-10-04 06:07:29,123 [salt.fileclient  ][INFO    ][23109] Caching directory '_states/' for environment 'base'
2017-10-04 06:07:29,162 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-04 06:07:29,215 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-04 06:07:29,251 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-04 06:07:29,287 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-04 06:07:29,324 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-04 06:07:29,358 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-04 06:07:29,400 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-04 06:07:29,460 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-04 06:07:29,498 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-04 06:07:29,529 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-04 06:07:29,593 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-04 06:07:29,630 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-04 06:07:29,685 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-04 06:07:29,723 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-04 06:07:29,790 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-04 06:07:29,822 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-04 06:07:29,851 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-04 06:07:29,862 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-04 06:07:29,873 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-04 06:07:29,884 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-04 06:07:29,925 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-04 06:07:29,955 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-04 06:07:29,978 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-04 06:07:30,009 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-04 06:07:30,045 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-04 06:07:30,091 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-04 06:07:30,102 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-04 06:07:30,150 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-04 06:07:30,173 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-04 06:07:30,175 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-04 06:07:30,176 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-04 06:07:30,184 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-04 06:07:30,185 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-04 06:07:30,185 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-04 06:07:30,185 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-04 06:07:30,185 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-04 06:07:30,186 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-04 06:07:30,186 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-04 06:07:30,186 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-04 06:07:30,186 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-04 06:07:30,187 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-04 06:07:30,187 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-04 06:07:30,187 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-04 06:07:30,187 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-04 06:07:30,188 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-04 06:07:30,188 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-04 06:07:30,188 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-04 06:07:30,188 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-04 06:07:30,189 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-04 06:07:30,189 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-04 06:07:30,189 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-04 06:07:30,189 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-04 06:07:30,190 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-04 06:07:30,190 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-04 06:07:30,190 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-04 06:07:30,190 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-04 06:07:30,191 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-04 06:07:30,191 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-04 06:07:30,191 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-04 06:07:30,193 [salt.utils.extmods][INFO    ][23109] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-04 06:07:30,196 [salt.utils.extmods][INFO    ][23109] Syncing sdb for environment 'base'
2017-10-04 06:07:30,196 [salt.utils.extmods][INFO    ][23109] Loading cache from salt://_sdb, for base)
2017-10-04 06:07:30,196 [salt.fileclient  ][INFO    ][23109] Caching directory '_sdb/' for environment 'base'
2017-10-04 06:07:30,241 [salt.utils.extmods][INFO    ][23109] Syncing grains for environment 'base'
2017-10-04 06:07:30,241 [salt.utils.extmods][INFO    ][23109] Loading cache from salt://_grains, for base)
2017-10-04 06:07:30,241 [salt.fileclient  ][INFO    ][23109] Caching directory '_grains/' for environment 'base'
2017-10-04 06:07:30,299 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-04 06:07:30,320 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-04 06:07:30,333 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-04 06:07:30,370 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-04 06:07:30,389 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-04 06:07:30,411 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-04 06:07:30,500 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-04 06:07:30,643 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-04 06:07:30,654 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-04 06:07:30,674 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-04 06:07:30,691 [salt.fileclient  ][INFO    ][23109] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-04 06:07:30,694 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-04 06:07:30,841 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-04 06:07:30,889 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-04 06:07:30,907 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-04 06:07:30,979 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-04 06:07:31,003 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-04 06:07:31,003 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-04 06:07:31,004 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-04 06:07:31,004 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-04 06:07:31,004 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-04 06:07:31,005 [salt.utils.extmods][INFO    ][23109] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-04 06:07:31,006 [salt.utils.extmods][INFO    ][23109] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-04 06:07:31,009 [salt.utils.extmods][INFO    ][23109] Syncing renderers for environment 'base'
2017-10-04 06:07:31,009 [salt.utils.extmods][INFO    ][23109] Loading cache from salt://_renderers, for base)
2017-10-04 06:07:31,009 [salt.fileclient  ][INFO    ][23109] Caching directory '_renderers/' for environment 'base'
2017-10-04 06:07:31,034 [salt.utils.extmods][INFO    ][23109] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-04 06:07:31,036 [salt.utils.extmods][INFO    ][23109] Syncing returners for environment 'base'
2017-10-04 06:07:31,037 [salt.utils.extmods][INFO    ][23109] Loading cache from salt://_returners, for base)
2017-10-04 06:07:31,037 [salt.fileclient  ][INFO    ][23109] Caching directory '_returners/' for environment 'base'
2017-10-04 06:07:31,059 [salt.utils.extmods][INFO    ][23109] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-04 06:07:31,061 [salt.utils.extmods][INFO    ][23109] Syncing output for environment 'base'
2017-10-04 06:07:31,061 [salt.utils.extmods][INFO    ][23109] Loading cache from salt://_output, for base)
2017-10-04 06:07:31,061 [salt.fileclient  ][INFO    ][23109] Caching directory '_output/' for environment 'base'
2017-10-04 06:07:31,117 [salt.utils.extmods][INFO    ][23109] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-04 06:07:31,120 [salt.utils.extmods][INFO    ][23109] Syncing utils for environment 'base'
2017-10-04 06:07:31,120 [salt.utils.extmods][INFO    ][23109] Loading cache from salt://_utils, for base)
2017-10-04 06:07:31,121 [salt.fileclient  ][INFO    ][23109] Caching directory '_utils/' for environment 'base'
2017-10-04 06:07:31,163 [salt.utils.extmods][INFO    ][23109] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-04 06:07:31,165 [salt.utils.extmods][INFO    ][23109] Syncing log_handlers for environment 'base'
2017-10-04 06:07:31,165 [salt.utils.extmods][INFO    ][23109] Loading cache from salt://_log_handlers, for base)
2017-10-04 06:07:31,165 [salt.fileclient  ][INFO    ][23109] Caching directory '_log_handlers/' for environment 'base'
2017-10-04 06:07:31,190 [salt.utils.extmods][INFO    ][23109] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-04 06:07:31,192 [salt.utils.extmods][INFO    ][23109] Syncing proxy for environment 'base'
2017-10-04 06:07:31,192 [salt.utils.extmods][INFO    ][23109] Loading cache from salt://_proxy, for base)
2017-10-04 06:07:31,192 [salt.fileclient  ][INFO    ][23109] Caching directory '_proxy/' for environment 'base'
2017-10-04 06:07:31,221 [salt.utils.extmods][INFO    ][23109] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-04 06:07:31,223 [salt.utils.extmods][INFO    ][23109] Syncing engines for environment 'base'
2017-10-04 06:07:31,223 [salt.utils.extmods][INFO    ][23109] Loading cache from salt://_engines, for base)
2017-10-04 06:07:31,224 [salt.fileclient  ][INFO    ][23109] Caching directory '_engines/' for environment 'base'
2017-10-04 06:07:31,256 [salt.minion      ][INFO    ][23109] Returning information for job: 20171004060725637901
2017-10-04 06:07:42,033 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command state.sls with jid 20171004060742027627
2017-10-04 06:07:42,047 [salt.minion      ][INFO    ][23207] Starting a new job with PID 23207
2017-10-04 06:07:42,545 [salt.state       ][INFO    ][23207] Loading fresh modules for state activity
2017-10-04 06:07:42,571 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-04 06:07:42,593 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-04 06:07:42,718 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-04 06:07:42,787 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-04 06:07:42,800 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-04 06:07:42,823 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-04 06:07:43,024 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-04 06:07:43,090 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-04 06:07:43,154 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-04 06:07:43,173 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-04 06:07:43,200 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-04 06:07:43,223 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-04 06:07:43,231 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-04 06:07:43,273 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-04 06:07:43,325 [py.warnings      ][WARNING ][23207] /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-10-04 06:07:43,325 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'salt-minion --version' in directory '/root'
2017-10-04 06:07:43,579 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-04 06:07:43,634 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-04 06:07:43,649 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-04 06:07:43,661 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-04 06:07:43,707 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-04 06:07:43,744 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-04 06:07:43,819 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-04 06:07:43,839 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-04 06:07:43,895 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-04 06:07:43,914 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-04 06:07:44,012 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-04 06:07:44,030 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-04 06:07:44,042 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-04 06:07:44,058 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-04 06:07:44,064 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-04 06:07:44,119 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-04 06:07:44,135 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'salt-minion --version' in directory '/root'
2017-10-04 06:07:44,380 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-04 06:07:44,399 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-04 06:07:44,488 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-04 06:07:44,501 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-04 06:07:44,546 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-04 06:07:44,662 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-04 06:07:44,727 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-04 06:07:44,781 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-04 06:07:45,243 [salt.state       ][INFO    ][23207] Running state [salt-minion] at time 06:07:45.242814
2017-10-04 06:07:45,243 [salt.state       ][INFO    ][23207] Executing state pkg.installed for salt-minion
2017-10-04 06:07:45,244 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-04 06:07:45,488 [salt.state       ][INFO    ][23207] Package salt-minion is already installed
2017-10-04 06:07:45,488 [salt.state       ][INFO    ][23207] Completed state [salt-minion] at time 06:07:45.487869 duration_in_ms=245.054
2017-10-04 06:07:45,488 [salt.state       ][INFO    ][23207] Running state [salt_minion_dependency_packages] at time 06:07:45.488083
2017-10-04 06:07:45,488 [salt.state       ][INFO    ][23207] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-04 06:07:45,491 [salt.state       ][INFO    ][23207] All specified packages are already installed
2017-10-04 06:07:45,491 [salt.state       ][INFO    ][23207] Completed state [salt_minion_dependency_packages] at time 06:07:45.490962 duration_in_ms=2.878
2017-10-04 06:07:45,492 [salt.state       ][INFO    ][23207] Running state [/etc/salt/minion.d/minion.conf] at time 06:07:45.492462
2017-10-04 06:07:45,493 [salt.state       ][INFO    ][23207] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-04 06:07:45,517 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-04 06:07:45,563 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-04 06:07:45,605 [salt.fileclient  ][INFO    ][23207] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-04 06:07:45,636 [salt.state       ][INFO    ][23207] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-04 06:07:45,636 [salt.state       ][INFO    ][23207] Completed state [/etc/salt/minion.d/minion.conf] at time 06:07:45.636322 duration_in_ms=143.86
2017-10-04 06:07:45,637 [salt.state       ][INFO    ][23207] Running state [/etc/salt/minion.d/_virt.conf] at time 06:07:45.636609
2017-10-04 06:07:45,637 [salt.state       ][INFO    ][23207] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-04 06:07:45,755 [salt.state       ][INFO    ][23207] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-04 06:07:45,756 [salt.state       ][INFO    ][23207] Completed state [/etc/salt/minion.d/_virt.conf] at time 06:07:45.755479 duration_in_ms=118.87
2017-10-04 06:07:45,757 [salt.state       ][INFO    ][23207] Running state [salt-minion] at time 06:07:45.757009
2017-10-04 06:07:45,757 [salt.state       ][INFO    ][23207] Executing state service.running for salt-minion
2017-10-04 06:07:45,758 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-04 06:07:45,775 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-04 06:07:45,783 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-04 06:07:45,791 [salt.state       ][INFO    ][23207] The service salt-minion is already running
2017-10-04 06:07:45,791 [salt.state       ][INFO    ][23207] Completed state [salt-minion] at time 06:07:45.791118 duration_in_ms=34.109
2017-10-04 06:07:45,792 [salt.state       ][INFO    ][23207] Running state [/etc/salt/grains.d] at time 06:07:45.792347
2017-10-04 06:07:45,793 [salt.state       ][INFO    ][23207] Executing state file.directory for /etc/salt/grains.d
2017-10-04 06:07:45,793 [salt.state       ][INFO    ][23207] Directory /etc/salt/grains.d is in the correct state
2017-10-04 06:07:45,793 [salt.state       ][INFO    ][23207] Completed state [/etc/salt/grains.d] at time 06:07:45.793190 duration_in_ms=0.844
2017-10-04 06:07:45,794 [salt.state       ][INFO    ][23207] Running state [/etc/salt/grains] at time 06:07:45.793587
2017-10-04 06:07:45,794 [salt.state       ][INFO    ][23207] Executing state file.managed for /etc/salt/grains
2017-10-04 06:07:45,794 [salt.state       ][INFO    ][23207] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-04 06:07:45,794 [salt.state       ][INFO    ][23207] Completed state [/etc/salt/grains] at time 06:07:45.794195 duration_in_ms=0.609
2017-10-04 06:07:45,794 [salt.state       ][INFO    ][23207] Running state [/etc/salt/grains.d/placeholder] at time 06:07:45.794469
2017-10-04 06:07:45,795 [salt.state       ][INFO    ][23207] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-04 06:07:45,795 [salt.state       ][INFO    ][23207] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-04 06:07:45,795 [salt.state       ][INFO    ][23207] Completed state [/etc/salt/grains.d/placeholder] at time 06:07:45.795052 duration_in_ms=0.583
2017-10-04 06:07:45,795 [salt.state       ][INFO    ][23207] Running state [/etc/salt/grains.d/sphinx] at time 06:07:45.795310
2017-10-04 06:07:45,795 [salt.state       ][INFO    ][23207] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-04 06:07:45,947 [salt.state       ][INFO    ][23207] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.143
               - 127.0.0.1
               - 192.168.11.251
-              - 192.168.122.1
         system:
           name: System
           param:

2017-10-04 06:07:45,948 [salt.state       ][INFO    ][23207] Completed state [/etc/salt/grains.d/sphinx] at time 06:07:45.947506 duration_in_ms=152.196
2017-10-04 06:07:45,948 [salt.state       ][INFO    ][23207] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:07:45.948137
2017-10-04 06:07:45,948 [salt.state       ][INFO    ][23207] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-04 06:07:45,949 [salt.state       ][INFO    ][23207] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-04 06:07:45,949 [salt.state       ][INFO    ][23207] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:07:45.948755 duration_in_ms=0.618
2017-10-04 06:07:45,949 [salt.state       ][INFO    ][23207] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:07:45.948919
2017-10-04 06:07:45,949 [salt.state       ][INFO    ][23207] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-04 06:07:45,950 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-10-04 06:07:46,029 [salt.state       ][INFO    ][23207] {'pid': 23255, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-04 06:07:46,029 [salt.state       ][INFO    ][23207] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:07:46.028904 duration_in_ms=79.985
2017-10-04 06:07:46,029 [salt.state       ][INFO    ][23207] Running state [/etc/salt/grains.d/dns_records] at time 06:07:46.029300
2017-10-04 06:07:46,030 [salt.state       ][INFO    ][23207] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-04 06:07:46,184 [salt.state       ][INFO    ][23207] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-04 06:07:46,185 [salt.state       ][INFO    ][23207] Completed state [/etc/salt/grains.d/dns_records] at time 06:07:46.184552 duration_in_ms=155.252
2017-10-04 06:07:46,185 [salt.state       ][INFO    ][23207] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 06:07:46.185252
2017-10-04 06:07:46,185 [salt.state       ][INFO    ][23207] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-04 06:07:46,186 [salt.state       ][INFO    ][23207] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-04 06:07:46,186 [salt.state       ][INFO    ][23207] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 06:07:46.185792 duration_in_ms=0.54
2017-10-04 06:07:46,186 [salt.state       ][INFO    ][23207] Running state [/etc/salt/grains.d/salt] at time 06:07:46.186065
2017-10-04 06:07:46,186 [salt.state       ][INFO    ][23207] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-04 06:07:46,285 [salt.state       ][INFO    ][23207] File /etc/salt/grains.d/salt is in the correct state
2017-10-04 06:07:46,285 [salt.state       ][INFO    ][23207] Completed state [/etc/salt/grains.d/salt] at time 06:07:46.284833 duration_in_ms=98.768
2017-10-04 06:07:46,286 [salt.state       ][INFO    ][23207] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 06:07:46.285471
2017-10-04 06:07:46,286 [salt.state       ][INFO    ][23207] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-04 06:07:46,286 [salt.state       ][INFO    ][23207] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-04 06:07:46,286 [salt.state       ][INFO    ][23207] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 06:07:46.286090 duration_in_ms=0.619
2017-10-04 06:07:46,287 [salt.state       ][INFO    ][23207] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:07:46.287392
2017-10-04 06:07:46,288 [salt.state       ][INFO    ][23207] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-04 06:07:46,288 [salt.state       ][INFO    ][23207] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-04 06:07:46,288 [salt.state       ][INFO    ][23207] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:07:46.288065 duration_in_ms=0.673
2017-10-04 06:07:46,288 [salt.state       ][INFO    ][23207] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:07:46.288244
2017-10-04 06:07:46,288 [salt.state       ][INFO    ][23207] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-04 06:07:46,290 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-10-04 06:07:46,300 [salt.state       ][INFO    ][23207] {'pid': 23257, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-04 06:07:46,300 [salt.state       ][INFO    ][23207] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:07:46.300007 duration_in_ms=11.763
2017-10-04 06:07:46,301 [salt.state       ][INFO    ][23207] Running state [mine.update] at time 06:07:46.300693
2017-10-04 06:07:46,301 [salt.state       ][INFO    ][23207] Executing state module.wait for mine.update
2017-10-04 06:07:46,301 [salt.state       ][INFO    ][23207] No changes made for mine.update
2017-10-04 06:07:46,301 [salt.state       ][INFO    ][23207] Completed state [mine.update] at time 06:07:46.301342 duration_in_ms=0.648
2017-10-04 06:07:46,302 [salt.state       ][INFO    ][23207] Running state [mine.update] at time 06:07:46.301507
2017-10-04 06:07:46,302 [salt.state       ][INFO    ][23207] Executing state module.mod_watch for mine.update
2017-10-04 06:07:46,823 [salt.state       ][INFO    ][23207] {'ret': True}
2017-10-04 06:07:46,823 [salt.state       ][INFO    ][23207] Completed state [mine.update] at time 06:07:46.823178 duration_in_ms=521.67
2017-10-04 06:07:46,824 [salt.state       ][INFO    ][23207] Running state [ca-certificates] at time 06:07:46.823474
2017-10-04 06:07:46,824 [salt.state       ][INFO    ][23207] Executing state pkg.installed for ca-certificates
2017-10-04 06:07:46,827 [salt.state       ][INFO    ][23207] Package ca-certificates is already installed
2017-10-04 06:07:46,827 [salt.state       ][INFO    ][23207] Completed state [ca-certificates] at time 06:07:46.827076 duration_in_ms=3.601
2017-10-04 06:07:46,828 [salt.state       ][INFO    ][23207] Running state [update-ca-certificates] at time 06:07:46.827676
2017-10-04 06:07:46,828 [salt.state       ][INFO    ][23207] Executing state cmd.wait for update-ca-certificates
2017-10-04 06:07:46,828 [salt.state       ][INFO    ][23207] No changes made for update-ca-certificates
2017-10-04 06:07:46,828 [salt.state       ][INFO    ][23207] Completed state [update-ca-certificates] at time 06:07:46.828315 duration_in_ms=0.64
2017-10-04 06:07:46,829 [salt.state       ][INFO    ][23207] Running state [libvirt-dev] at time 06:07:46.828510
2017-10-04 06:07:46,829 [salt.state       ][INFO    ][23207] Executing state pkg.installed for libvirt-dev
2017-10-04 06:07:46,831 [salt.state       ][INFO    ][23207] Package libvirt-dev is already installed
2017-10-04 06:07:46,832 [salt.state       ][INFO    ][23207] Completed state [libvirt-dev] at time 06:07:46.831604 duration_in_ms=3.094
2017-10-04 06:07:46,832 [salt.state       ][INFO    ][23207] Running state [pkg-config] at time 06:07:46.831794
2017-10-04 06:07:46,832 [salt.state       ][INFO    ][23207] Executing state pkg.installed for pkg-config
2017-10-04 06:07:46,835 [salt.state       ][INFO    ][23207] Package pkg-config is already installed
2017-10-04 06:07:46,835 [salt.state       ][INFO    ][23207] Completed state [pkg-config] at time 06:07:46.834897 duration_in_ms=3.102
2017-10-04 06:07:46,835 [salt.state       ][INFO    ][23207] Running state [virtng.init] at time 06:07:46.835097
2017-10-04 06:07:46,835 [salt.state       ][INFO    ][23207] Executing state module.run for virtng.init
2017-10-04 06:07:46,907 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command ['git', '--version'] in directory '/root'
2017-10-04 06:07:46,995 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:07:47,012 [salt.state       ][INFO    ][23207] unless execution succeeded
2017-10-04 06:07:47,013 [salt.state       ][INFO    ][23207] Completed state [virtng.init] at time 06:07:47.012483 duration_in_ms=177.383
2017-10-04 06:07:47,013 [salt.state       ][INFO    ][23207] Running state [virt.set_autostart] at time 06:07:47.012736
2017-10-04 06:07:47,013 [salt.state       ][INFO    ][23207] Executing state module.run for virt.set_autostart
2017-10-04 06:07:47,015 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:07:47,031 [salt.state       ][INFO    ][23207] unless execution succeeded
2017-10-04 06:07:47,031 [salt.state       ][INFO    ][23207] Completed state [virt.set_autostart] at time 06:07:47.031064 duration_in_ms=18.327
2017-10-04 06:07:47,031 [salt.state       ][INFO    ][23207] Running state [virtng.init] at time 06:07:47.031380
2017-10-04 06:07:47,032 [salt.state       ][INFO    ][23207] Executing state module.run for virtng.init
2017-10-04 06:07:47,034 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:07:47,050 [salt.state       ][INFO    ][23207] unless execution succeeded
2017-10-04 06:07:47,050 [salt.state       ][INFO    ][23207] Completed state [virtng.init] at time 06:07:47.050280 duration_in_ms=18.9
2017-10-04 06:07:47,051 [salt.state       ][INFO    ][23207] Running state [virt.set_autostart] at time 06:07:47.050516
2017-10-04 06:07:47,051 [salt.state       ][INFO    ][23207] Executing state module.run for virt.set_autostart
2017-10-04 06:07:47,053 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:07:47,069 [salt.state       ][INFO    ][23207] unless execution succeeded
2017-10-04 06:07:47,069 [salt.state       ][INFO    ][23207] Completed state [virt.set_autostart] at time 06:07:47.069254 duration_in_ms=18.737
2017-10-04 06:07:47,070 [salt.state       ][INFO    ][23207] Running state [virtng.init] at time 06:07:47.069535
2017-10-04 06:07:47,070 [salt.state       ][INFO    ][23207] Executing state module.run for virtng.init
2017-10-04 06:07:47,072 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:07:47,088 [salt.state       ][INFO    ][23207] unless execution succeeded
2017-10-04 06:07:47,088 [salt.state       ][INFO    ][23207] Completed state [virtng.init] at time 06:07:47.088300 duration_in_ms=18.764
2017-10-04 06:07:47,089 [salt.state       ][INFO    ][23207] Running state [virt.set_autostart] at time 06:07:47.088525
2017-10-04 06:07:47,089 [salt.state       ][INFO    ][23207] Executing state module.run for virt.set_autostart
2017-10-04 06:07:47,091 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:07:47,107 [salt.state       ][INFO    ][23207] unless execution succeeded
2017-10-04 06:07:47,107 [salt.state       ][INFO    ][23207] Completed state [virt.set_autostart] at time 06:07:47.106753 duration_in_ms=18.227
2017-10-04 06:07:47,107 [salt.state       ][INFO    ][23207] Running state [virtng.init] at time 06:07:47.106973
2017-10-04 06:07:47,107 [salt.state       ][INFO    ][23207] Executing state module.run for virtng.init
2017-10-04 06:07:47,109 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:07:47,124 [salt.state       ][INFO    ][23207] unless execution succeeded
2017-10-04 06:07:47,124 [salt.state       ][INFO    ][23207] Completed state [virtng.init] at time 06:07:47.124231 duration_in_ms=17.258
2017-10-04 06:07:47,124 [salt.state       ][INFO    ][23207] Running state [virt.set_autostart] at time 06:07:47.124451
2017-10-04 06:07:47,125 [salt.state       ][INFO    ][23207] Executing state module.run for virt.set_autostart
2017-10-04 06:07:47,127 [salt.loaded.int.module.cmdmod][INFO    ][23207] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:07:47,142 [salt.state       ][INFO    ][23207] unless execution succeeded
2017-10-04 06:07:47,142 [salt.state       ][INFO    ][23207] Completed state [virt.set_autostart] at time 06:07:47.142118 duration_in_ms=17.667
2017-10-04 06:07:47,144 [salt.minion      ][INFO    ][23207] Returning information for job: 20171004060742027627
2017-10-04 06:09:03,803 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command state.sls with jid 20171004060903793923
2017-10-04 06:09:03,818 [salt.minion      ][INFO    ][23317] Starting a new job with PID 23317
2017-10-04 06:09:05,349 [salt.state       ][INFO    ][23317] Loading fresh modules for state activity
2017-10-04 06:09:05,376 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-04 06:09:05,394 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-04 06:09:05,460 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-04 06:09:05,523 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-04 06:09:05,537 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-04 06:09:05,563 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-04 06:09:05,615 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-04 06:09:05,634 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-04 06:09:05,676 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-04 06:09:05,694 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-04 06:09:05,935 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-04 06:09:05,951 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-04 06:09:05,958 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-04 06:09:05,980 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-04 06:09:05,996 [py.warnings      ][WARNING ][23317] /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-10-04 06:09:05,996 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command 'salt-minion --version' in directory '/root'
2017-10-04 06:09:06,250 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-04 06:09:06,264 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-04 06:09:06,273 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-04 06:09:06,281 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-04 06:09:06,319 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-04 06:09:06,350 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-04 06:09:06,406 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-04 06:09:06,425 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-04 06:09:06,477 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-04 06:09:06,493 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-04 06:09:06,533 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-04 06:09:06,550 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-04 06:09:06,563 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-04 06:09:06,577 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-04 06:09:06,583 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-04 06:09:06,605 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-04 06:09:06,621 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command 'salt-minion --version' in directory '/root'
2017-10-04 06:09:06,882 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-04 06:09:06,901 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-04 06:09:06,913 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-04 06:09:06,925 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-04 06:09:06,971 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-04 06:09:07,006 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-04 06:09:07,070 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-04 06:09:07,125 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-04 06:09:07,423 [salt.state       ][INFO    ][23317] Running state [salt-minion] at time 06:09:07.422547
2017-10-04 06:09:07,423 [salt.state       ][INFO    ][23317] Executing state pkg.installed for salt-minion
2017-10-04 06:09:07,424 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-04 06:09:07,711 [salt.state       ][INFO    ][23317] Package salt-minion is already installed
2017-10-04 06:09:07,711 [salt.state       ][INFO    ][23317] Completed state [salt-minion] at time 06:09:07.711412 duration_in_ms=288.865
2017-10-04 06:09:07,712 [salt.state       ][INFO    ][23317] Running state [salt_minion_dependency_packages] at time 06:09:07.711704
2017-10-04 06:09:07,712 [salt.state       ][INFO    ][23317] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-04 06:09:07,715 [salt.state       ][INFO    ][23317] All specified packages are already installed
2017-10-04 06:09:07,715 [salt.state       ][INFO    ][23317] Completed state [salt_minion_dependency_packages] at time 06:09:07.714753 duration_in_ms=3.05
2017-10-04 06:09:07,717 [salt.state       ][INFO    ][23317] Running state [/etc/salt/minion.d/minion.conf] at time 06:09:07.716493
2017-10-04 06:09:07,717 [salt.state       ][INFO    ][23317] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-04 06:09:07,742 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-04 06:09:07,788 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-04 06:09:07,831 [salt.fileclient  ][INFO    ][23317] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-04 06:09:07,864 [salt.state       ][INFO    ][23317] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-04 06:09:07,864 [salt.state       ][INFO    ][23317] Completed state [/etc/salt/minion.d/minion.conf] at time 06:09:07.863984 duration_in_ms=147.491
2017-10-04 06:09:07,864 [salt.state       ][INFO    ][23317] Running state [/etc/salt/minion.d/_virt.conf] at time 06:09:07.864280
2017-10-04 06:09:07,864 [salt.state       ][INFO    ][23317] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-04 06:09:07,870 [salt.state       ][INFO    ][23317] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-04 06:09:07,870 [salt.state       ][INFO    ][23317] Completed state [/etc/salt/minion.d/_virt.conf] at time 06:09:07.869840 duration_in_ms=5.561
2017-10-04 06:09:07,871 [salt.state       ][INFO    ][23317] Running state [salt-minion] at time 06:09:07.871247
2017-10-04 06:09:07,871 [salt.state       ][INFO    ][23317] Executing state service.running for salt-minion
2017-10-04 06:09:07,872 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-04 06:09:07,893 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-04 06:09:07,902 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-04 06:09:07,911 [salt.state       ][INFO    ][23317] The service salt-minion is already running
2017-10-04 06:09:07,911 [salt.state       ][INFO    ][23317] Completed state [salt-minion] at time 06:09:07.910898 duration_in_ms=39.65
2017-10-04 06:09:07,912 [salt.state       ][INFO    ][23317] Running state [/etc/salt/grains.d] at time 06:09:07.912162
2017-10-04 06:09:07,912 [salt.state       ][INFO    ][23317] Executing state file.directory for /etc/salt/grains.d
2017-10-04 06:09:07,913 [salt.state       ][INFO    ][23317] Directory /etc/salt/grains.d is in the correct state
2017-10-04 06:09:07,913 [salt.state       ][INFO    ][23317] Completed state [/etc/salt/grains.d] at time 06:09:07.912990 duration_in_ms=0.828
2017-10-04 06:09:07,913 [salt.state       ][INFO    ][23317] Running state [/etc/salt/grains] at time 06:09:07.913395
2017-10-04 06:09:07,914 [salt.state       ][INFO    ][23317] Executing state file.managed for /etc/salt/grains
2017-10-04 06:09:07,914 [salt.state       ][INFO    ][23317] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-04 06:09:07,914 [salt.state       ][INFO    ][23317] Completed state [/etc/salt/grains] at time 06:09:07.914004 duration_in_ms=0.609
2017-10-04 06:09:07,914 [salt.state       ][INFO    ][23317] Running state [/etc/salt/grains.d/placeholder] at time 06:09:07.914262
2017-10-04 06:09:07,914 [salt.state       ][INFO    ][23317] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-04 06:09:07,915 [salt.state       ][INFO    ][23317] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-04 06:09:07,915 [salt.state       ][INFO    ][23317] Completed state [/etc/salt/grains.d/placeholder] at time 06:09:07.914813 duration_in_ms=0.55
2017-10-04 06:09:07,915 [salt.state       ][INFO    ][23317] Running state [/etc/salt/grains.d/sphinx] at time 06:09:07.915070
2017-10-04 06:09:07,915 [salt.state       ][INFO    ][23317] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-04 06:09:07,923 [salt.state       ][INFO    ][23317] File /etc/salt/grains.d/sphinx is in the correct state
2017-10-04 06:09:07,923 [salt.state       ][INFO    ][23317] Completed state [/etc/salt/grains.d/sphinx] at time 06:09:07.922754 duration_in_ms=7.684
2017-10-04 06:09:07,923 [salt.state       ][INFO    ][23317] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:09:07.923278
2017-10-04 06:09:07,923 [salt.state       ][INFO    ][23317] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-04 06:09:07,924 [salt.state       ][INFO    ][23317] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-04 06:09:07,924 [salt.state       ][INFO    ][23317] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:09:07.923754 duration_in_ms=0.475
2017-10-04 06:09:07,924 [salt.state       ][INFO    ][23317] Running state [/etc/salt/grains.d/dns_records] at time 06:09:07.924005
2017-10-04 06:09:07,924 [salt.state       ][INFO    ][23317] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-04 06:09:07,928 [salt.state       ][INFO    ][23317] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-04 06:09:07,928 [salt.state       ][INFO    ][23317] Completed state [/etc/salt/grains.d/dns_records] at time 06:09:07.928405 duration_in_ms=4.4
2017-10-04 06:09:07,929 [salt.state       ][INFO    ][23317] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 06:09:07.928934
2017-10-04 06:09:07,929 [salt.state       ][INFO    ][23317] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-04 06:09:07,929 [salt.state       ][INFO    ][23317] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-04 06:09:07,929 [salt.state       ][INFO    ][23317] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 06:09:07.929392 duration_in_ms=0.458
2017-10-04 06:09:07,930 [salt.state       ][INFO    ][23317] Running state [/etc/salt/grains.d/salt] at time 06:09:07.929649
2017-10-04 06:09:07,930 [salt.state       ][INFO    ][23317] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-04 06:09:07,934 [salt.state       ][INFO    ][23317] File /etc/salt/grains.d/salt is in the correct state
2017-10-04 06:09:07,935 [salt.state       ][INFO    ][23317] Completed state [/etc/salt/grains.d/salt] at time 06:09:07.934517 duration_in_ms=4.868
2017-10-04 06:09:07,935 [salt.state       ][INFO    ][23317] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 06:09:07.935018
2017-10-04 06:09:07,935 [salt.state       ][INFO    ][23317] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-04 06:09:07,935 [salt.state       ][INFO    ][23317] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-04 06:09:07,936 [salt.state       ][INFO    ][23317] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 06:09:07.935475 duration_in_ms=0.457
2017-10-04 06:09:07,937 [salt.state       ][INFO    ][23317] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:09:07.936579
2017-10-04 06:09:07,937 [salt.state       ][INFO    ][23317] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-04 06:09:07,937 [salt.state       ][INFO    ][23317] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-04 06:09:07,937 [salt.state       ][INFO    ][23317] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:09:07.937040 duration_in_ms=0.462
2017-10-04 06:09:07,937 [salt.state       ][INFO    ][23317] Running state [mine.update] at time 06:09:07.937421
2017-10-04 06:09:07,938 [salt.state       ][INFO    ][23317] Executing state module.wait for mine.update
2017-10-04 06:09:07,938 [salt.state       ][INFO    ][23317] No changes made for mine.update
2017-10-04 06:09:07,938 [salt.state       ][INFO    ][23317] Completed state [mine.update] at time 06:09:07.937840 duration_in_ms=0.418
2017-10-04 06:09:07,938 [salt.state       ][INFO    ][23317] Running state [ca-certificates] at time 06:09:07.937972
2017-10-04 06:09:07,938 [salt.state       ][INFO    ][23317] Executing state pkg.installed for ca-certificates
2017-10-04 06:09:07,941 [salt.state       ][INFO    ][23317] Package ca-certificates is already installed
2017-10-04 06:09:07,941 [salt.state       ][INFO    ][23317] Completed state [ca-certificates] at time 06:09:07.940990 duration_in_ms=3.018
2017-10-04 06:09:07,941 [salt.state       ][INFO    ][23317] Running state [update-ca-certificates] at time 06:09:07.941383
2017-10-04 06:09:07,942 [salt.state       ][INFO    ][23317] Executing state cmd.wait for update-ca-certificates
2017-10-04 06:09:07,942 [salt.state       ][INFO    ][23317] No changes made for update-ca-certificates
2017-10-04 06:09:07,942 [salt.state       ][INFO    ][23317] Completed state [update-ca-certificates] at time 06:09:07.941820 duration_in_ms=0.437
2017-10-04 06:09:07,942 [salt.state       ][INFO    ][23317] Running state [libvirt-dev] at time 06:09:07.941952
2017-10-04 06:09:07,942 [salt.state       ][INFO    ][23317] Executing state pkg.installed for libvirt-dev
2017-10-04 06:09:07,945 [salt.state       ][INFO    ][23317] Package libvirt-dev is already installed
2017-10-04 06:09:07,945 [salt.state       ][INFO    ][23317] Completed state [libvirt-dev] at time 06:09:07.944741 duration_in_ms=2.789
2017-10-04 06:09:07,945 [salt.state       ][INFO    ][23317] Running state [pkg-config] at time 06:09:07.944876
2017-10-04 06:09:07,945 [salt.state       ][INFO    ][23317] Executing state pkg.installed for pkg-config
2017-10-04 06:09:07,948 [salt.state       ][INFO    ][23317] Package pkg-config is already installed
2017-10-04 06:09:07,948 [salt.state       ][INFO    ][23317] Completed state [pkg-config] at time 06:09:07.947679 duration_in_ms=2.803
2017-10-04 06:09:07,948 [salt.state       ][INFO    ][23317] Running state [virtng.init] at time 06:09:07.947817
2017-10-04 06:09:07,948 [salt.state       ][INFO    ][23317] Executing state module.run for virtng.init
2017-10-04 06:09:07,986 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command ['git', '--version'] in directory '/root'
2017-10-04 06:09:08,075 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:09:08,094 [salt.state       ][INFO    ][23317] unless execution succeeded
2017-10-04 06:09:08,095 [salt.state       ][INFO    ][23317] Completed state [virtng.init] at time 06:09:08.094602 duration_in_ms=146.782
2017-10-04 06:09:08,095 [salt.state       ][INFO    ][23317] Running state [virt.set_autostart] at time 06:09:08.094876
2017-10-04 06:09:08,095 [salt.state       ][INFO    ][23317] Executing state module.run for virt.set_autostart
2017-10-04 06:09:08,097 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:09:08,116 [salt.state       ][INFO    ][23317] unless execution succeeded
2017-10-04 06:09:08,117 [salt.state       ][INFO    ][23317] Completed state [virt.set_autostart] at time 06:09:08.116552 duration_in_ms=21.676
2017-10-04 06:09:08,117 [salt.state       ][INFO    ][23317] Running state [virtng.init] at time 06:09:08.116786
2017-10-04 06:09:08,117 [salt.state       ][INFO    ][23317] Executing state module.run for virtng.init
2017-10-04 06:09:08,119 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:09:08,135 [salt.state       ][INFO    ][23317] unless execution succeeded
2017-10-04 06:09:08,135 [salt.state       ][INFO    ][23317] Completed state [virtng.init] at time 06:09:08.134999 duration_in_ms=18.213
2017-10-04 06:09:08,135 [salt.state       ][INFO    ][23317] Running state [virt.set_autostart] at time 06:09:08.135239
2017-10-04 06:09:08,135 [salt.state       ][INFO    ][23317] Executing state module.run for virt.set_autostart
2017-10-04 06:09:08,137 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:09:08,154 [salt.state       ][INFO    ][23317] unless execution succeeded
2017-10-04 06:09:08,154 [salt.state       ][INFO    ][23317] Completed state [virt.set_autostart] at time 06:09:08.154143 duration_in_ms=18.904
2017-10-04 06:09:08,154 [salt.state       ][INFO    ][23317] Running state [virtng.init] at time 06:09:08.154363
2017-10-04 06:09:08,155 [salt.state       ][INFO    ][23317] Executing state module.run for virtng.init
2017-10-04 06:09:08,156 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:09:08,171 [salt.state       ][INFO    ][23317] unless execution succeeded
2017-10-04 06:09:08,171 [salt.state       ][INFO    ][23317] Completed state [virtng.init] at time 06:09:08.171112 duration_in_ms=16.748
2017-10-04 06:09:08,171 [salt.state       ][INFO    ][23317] Running state [virt.set_autostart] at time 06:09:08.171344
2017-10-04 06:09:08,172 [salt.state       ][INFO    ][23317] Executing state module.run for virt.set_autostart
2017-10-04 06:09:08,174 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:09:08,190 [salt.state       ][INFO    ][23317] unless execution succeeded
2017-10-04 06:09:08,190 [salt.state       ][INFO    ][23317] Completed state [virt.set_autostart] at time 06:09:08.189735 duration_in_ms=18.39
2017-10-04 06:09:08,190 [salt.state       ][INFO    ][23317] Running state [virtng.init] at time 06:09:08.189997
2017-10-04 06:09:08,190 [salt.state       ][INFO    ][23317] Executing state module.run for virtng.init
2017-10-04 06:09:08,192 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:09:08,207 [salt.state       ][INFO    ][23317] unless execution succeeded
2017-10-04 06:09:08,207 [salt.state       ][INFO    ][23317] Completed state [virtng.init] at time 06:09:08.207376 duration_in_ms=17.379
2017-10-04 06:09:08,208 [salt.state       ][INFO    ][23317] Running state [virt.set_autostart] at time 06:09:08.207601
2017-10-04 06:09:08,208 [salt.state       ][INFO    ][23317] Executing state module.run for virt.set_autostart
2017-10-04 06:09:08,210 [salt.loaded.int.module.cmdmod][INFO    ][23317] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-04 06:09:08,226 [salt.state       ][INFO    ][23317] unless execution succeeded
2017-10-04 06:09:08,227 [salt.state       ][INFO    ][23317] Completed state [virt.set_autostart] at time 06:09:08.226670 duration_in_ms=19.069
2017-10-04 06:09:08,229 [salt.minion      ][INFO    ][23317] Returning information for job: 20171004060903793923
2017-10-04 06:10:06,298 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171004061006289253
2017-10-04 06:10:06,318 [salt.minion      ][INFO    ][23426] Starting a new job with PID 23426
2017-10-04 06:10:09,393 [salt.state       ][INFO    ][23426] Loading fresh modules for state activity
2017-10-04 06:10:09,600 [salt.state       ][ERROR   ][23426] No contents found in top file
2017-10-04 06:10:09,601 [salt.utils.extmods][INFO    ][23426] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-04 06:10:09,604 [salt.utils.extmods][INFO    ][23426] Syncing beacons for environment 'base'
2017-10-04 06:10:09,604 [salt.utils.extmods][INFO    ][23426] Loading cache from salt://_beacons, for base)
2017-10-04 06:10:09,604 [salt.fileclient  ][INFO    ][23426] Caching directory '_beacons/' for environment 'base'
2017-10-04 06:10:09,639 [salt.utils.extmods][INFO    ][23426] Syncing modules for environment 'base'
2017-10-04 06:10:09,639 [salt.utils.extmods][INFO    ][23426] Loading cache from salt://_modules, for base)
2017-10-04 06:10:09,640 [salt.fileclient  ][INFO    ][23426] Caching directory '_modules/' for environment 'base'
2017-10-04 06:10:09,714 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-04 06:10:09,722 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-04 06:10:09,732 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-04 06:10:09,750 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-04 06:10:09,758 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-04 06:10:09,764 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-04 06:10:09,775 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-04 06:10:09,782 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-04 06:10:09,818 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-04 06:10:09,832 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-04 06:10:09,839 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-04 06:10:09,850 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-04 06:10:09,858 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-04 06:10:09,869 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-04 06:10:09,875 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-04 06:10:09,885 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-04 06:10:09,913 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-04 06:10:09,927 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-04 06:10:09,943 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-04 06:10:09,959 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-04 06:10:09,971 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-04 06:10:10,004 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-04 06:10:10,043 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-04 06:10:10,054 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-04 06:10:10,095 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-04 06:10:10,126 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-04 06:10:10,165 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-04 06:10:10,185 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-04 06:10:10,193 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-04 06:10:10,202 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-04 06:10:10,209 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-04 06:10:10,223 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-04 06:10:10,226 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-04 06:10:10,226 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-04 06:10:10,227 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-04 06:10:10,227 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-04 06:10:10,227 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-04 06:10:10,227 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-04 06:10:10,227 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-04 06:10:10,228 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-04 06:10:10,228 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-04 06:10:10,228 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-04 06:10:10,228 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-04 06:10:10,228 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-04 06:10:10,229 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-04 06:10:10,229 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-04 06:10:10,229 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-04 06:10:10,229 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-04 06:10:10,229 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-04 06:10:10,230 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-04 06:10:10,230 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-04 06:10:10,230 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-04 06:10:10,230 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-04 06:10:10,230 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-04 06:10:10,231 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-04 06:10:10,231 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-04 06:10:10,231 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-04 06:10:10,231 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-04 06:10:10,232 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-04 06:10:10,232 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-04 06:10:10,232 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-04 06:10:10,232 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-04 06:10:10,232 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-04 06:10:10,233 [salt.utils.extmods][INFO    ][23426] 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-10-04 06:10:10,233 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-04 06:10:10,233 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-04 06:10:10,237 [salt.utils.extmods][INFO    ][23426] Syncing states for environment 'base'
2017-10-04 06:10:10,237 [salt.utils.extmods][INFO    ][23426] Loading cache from salt://_states, for base)
2017-10-04 06:10:10,238 [salt.fileclient  ][INFO    ][23426] Caching directory '_states/' for environment 'base'
2017-10-04 06:10:10,278 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-04 06:10:10,334 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-04 06:10:10,346 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-04 06:10:10,357 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-04 06:10:10,369 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-04 06:10:10,391 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-04 06:10:10,415 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-04 06:10:10,432 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-04 06:10:10,461 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-04 06:10:10,468 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-04 06:10:10,478 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-04 06:10:10,490 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-04 06:10:10,502 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-04 06:10:10,513 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-04 06:10:10,520 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-04 06:10:10,538 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-04 06:10:10,546 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-04 06:10:10,553 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-04 06:10:10,576 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-04 06:10:10,584 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-04 06:10:10,599 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-04 06:10:10,618 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-04 06:10:10,639 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-04 06:10:10,654 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-04 06:10:10,687 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-04 06:10:10,696 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-04 06:10:10,708 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-04 06:10:10,764 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-04 06:10:10,779 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-04 06:10:10,782 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-04 06:10:10,782 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-04 06:10:10,782 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-04 06:10:10,783 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-04 06:10:10,783 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-04 06:10:10,783 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-04 06:10:10,783 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-04 06:10:10,783 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-04 06:10:10,784 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-04 06:10:10,784 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-04 06:10:10,784 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-04 06:10:10,784 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-04 06:10:10,784 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-04 06:10:10,785 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-04 06:10:10,785 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-04 06:10:10,785 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-04 06:10:10,785 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-04 06:10:10,785 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-04 06:10:10,786 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-04 06:10:10,786 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-04 06:10:10,786 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-04 06:10:10,786 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-04 06:10:10,786 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-04 06:10:10,787 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-04 06:10:10,787 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-04 06:10:10,787 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-04 06:10:10,787 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-04 06:10:10,787 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-04 06:10:10,788 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-04 06:10:10,788 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-04 06:10:10,790 [salt.utils.extmods][INFO    ][23426] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-04 06:10:10,792 [salt.utils.extmods][INFO    ][23426] Syncing sdb for environment 'base'
2017-10-04 06:10:10,792 [salt.utils.extmods][INFO    ][23426] Loading cache from salt://_sdb, for base)
2017-10-04 06:10:10,793 [salt.fileclient  ][INFO    ][23426] Caching directory '_sdb/' for environment 'base'
2017-10-04 06:10:10,820 [salt.utils.extmods][INFO    ][23426] Syncing grains for environment 'base'
2017-10-04 06:10:10,820 [salt.utils.extmods][INFO    ][23426] Loading cache from salt://_grains, for base)
2017-10-04 06:10:10,820 [salt.fileclient  ][INFO    ][23426] Caching directory '_grains/' for environment 'base'
2017-10-04 06:10:10,862 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-04 06:10:10,871 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-04 06:10:10,880 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-04 06:10:10,903 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-04 06:10:10,921 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-04 06:10:10,931 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-04 06:10:10,944 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-04 06:10:10,968 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-04 06:10:10,995 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-04 06:10:11,011 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-04 06:10:11,018 [salt.fileclient  ][INFO    ][23426] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-04 06:10:11,022 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-04 06:10:11,023 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-04 06:10:11,023 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-04 06:10:11,023 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-04 06:10:11,024 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-04 06:10:11,024 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-04 06:10:11,024 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-04 06:10:11,024 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-04 06:10:11,025 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-04 06:10:11,025 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-04 06:10:11,025 [salt.utils.extmods][INFO    ][23426] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-04 06:10:11,027 [salt.utils.extmods][INFO    ][23426] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-04 06:10:11,031 [salt.utils.extmods][INFO    ][23426] Syncing renderers for environment 'base'
2017-10-04 06:10:11,031 [salt.utils.extmods][INFO    ][23426] Loading cache from salt://_renderers, for base)
2017-10-04 06:10:11,031 [salt.fileclient  ][INFO    ][23426] Caching directory '_renderers/' for environment 'base'
2017-10-04 06:10:11,075 [salt.utils.extmods][INFO    ][23426] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-04 06:10:11,077 [salt.utils.extmods][INFO    ][23426] Syncing returners for environment 'base'
2017-10-04 06:10:11,077 [salt.utils.extmods][INFO    ][23426] Loading cache from salt://_returners, for base)
2017-10-04 06:10:11,077 [salt.fileclient  ][INFO    ][23426] Caching directory '_returners/' for environment 'base'
2017-10-04 06:10:11,099 [salt.utils.extmods][INFO    ][23426] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-04 06:10:11,102 [salt.utils.extmods][INFO    ][23426] Syncing output for environment 'base'
2017-10-04 06:10:11,102 [salt.utils.extmods][INFO    ][23426] Loading cache from salt://_output, for base)
2017-10-04 06:10:11,102 [salt.fileclient  ][INFO    ][23426] Caching directory '_output/' for environment 'base'
2017-10-04 06:10:11,124 [salt.utils.extmods][INFO    ][23426] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-04 06:10:11,126 [salt.utils.extmods][INFO    ][23426] Syncing utils for environment 'base'
2017-10-04 06:10:11,126 [salt.utils.extmods][INFO    ][23426] Loading cache from salt://_utils, for base)
2017-10-04 06:10:11,127 [salt.fileclient  ][INFO    ][23426] Caching directory '_utils/' for environment 'base'
2017-10-04 06:10:11,159 [salt.utils.extmods][INFO    ][23426] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-04 06:10:11,162 [salt.utils.extmods][INFO    ][23426] Syncing log_handlers for environment 'base'
2017-10-04 06:10:11,162 [salt.utils.extmods][INFO    ][23426] Loading cache from salt://_log_handlers, for base)
2017-10-04 06:10:11,162 [salt.fileclient  ][INFO    ][23426] Caching directory '_log_handlers/' for environment 'base'
2017-10-04 06:10:11,194 [salt.utils.extmods][INFO    ][23426] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-04 06:10:11,198 [salt.utils.extmods][INFO    ][23426] Syncing proxy for environment 'base'
2017-10-04 06:10:11,198 [salt.utils.extmods][INFO    ][23426] Loading cache from salt://_proxy, for base)
2017-10-04 06:10:11,198 [salt.fileclient  ][INFO    ][23426] Caching directory '_proxy/' for environment 'base'
2017-10-04 06:10:11,220 [salt.utils.extmods][INFO    ][23426] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-04 06:10:11,222 [salt.utils.extmods][INFO    ][23426] Syncing engines for environment 'base'
2017-10-04 06:10:11,222 [salt.utils.extmods][INFO    ][23426] Loading cache from salt://_engines, for base)
2017-10-04 06:10:11,222 [salt.fileclient  ][INFO    ][23426] Caching directory '_engines/' for environment 'base'
2017-10-04 06:10:11,249 [salt.minion      ][INFO    ][23426] Returning information for job: 20171004061006289253
2017-10-04 06:20:06,172 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command test.ping with jid 20171004062006166925
2017-10-04 06:20:06,192 [salt.minion      ][INFO    ][23651] Starting a new job with PID 23651
2017-10-04 06:20:06,217 [salt.minion      ][INFO    ][23651] Returning information for job: 20171004062006166925
2017-10-04 06:23:39,577 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command state.sls with jid 20171004062339569994
2017-10-04 06:23:39,593 [salt.minion      ][INFO    ][23702] Starting a new job with PID 23702
2017-10-04 06:23:39,985 [salt.state       ][INFO    ][23702] Loading fresh modules for state activity
2017-10-04 06:23:40,010 [salt.fileclient  ][INFO    ][23702] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-04 06:23:40,027 [salt.fileclient  ][INFO    ][23702] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-04 06:23:40,051 [salt.fileclient  ][INFO    ][23702] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-04 06:23:40,343 [salt.state       ][INFO    ][23702] Running state [lsof] at time 06:23:40.342504
2017-10-04 06:23:40,343 [salt.state       ][INFO    ][23702] Executing state pkg.installed for lsof
2017-10-04 06:23:40,343 [salt.loaded.int.module.cmdmod][INFO    ][23702] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-04 06:23:40,626 [salt.state       ][INFO    ][23702] Package lsof is already installed
2017-10-04 06:23:40,626 [salt.state       ][INFO    ][23702] Completed state [lsof] at time 06:23:40.626453 duration_in_ms=283.95
2017-10-04 06:23:40,644 [salt.state       ][INFO    ][23702] Running state [keepalived] at time 06:23:40.643670
2017-10-04 06:23:40,644 [salt.state       ][INFO    ][23702] Executing state pkg.installed for keepalived
2017-10-04 06:23:40,659 [salt.loaded.int.module.cmdmod][INFO    ][23702] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-04 06:23:42,551 [salt.loaded.int.module.cmdmod][INFO    ][23702] 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-10-04 06:23:49,621 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004062349614575
2017-10-04 06:23:49,636 [salt.minion      ][INFO    ][25164] Starting a new job with PID 25164
2017-10-04 06:23:49,646 [salt.minion      ][INFO    ][25164] Returning information for job: 20171004062349614575
2017-10-04 06:23:50,474 [salt.loaded.int.module.cmdmod][INFO    ][23702] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-04 06:23:50,497 [salt.state       ][INFO    ][23702] 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-10-04 06:23:50,506 [salt.state       ][INFO    ][23702] Loading fresh modules for state activity
2017-10-04 06:23:50,518 [salt.state       ][INFO    ][23702] Completed state [keepalived] at time 06:23:50.517568 duration_in_ms=9873.898
2017-10-04 06:23:50,519 [salt.state       ][INFO    ][23702] Running state [/etc/keepalived/keepalived.conf] at time 06:23:50.519411
2017-10-04 06:23:50,520 [salt.state       ][INFO    ][23702] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-04 06:23:50,545 [salt.fileclient  ][INFO    ][23702] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-04 06:23:50,575 [salt.fileclient  ][INFO    ][23702] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-04 06:23:50,581 [salt.state       ][INFO    ][23702] File changed:
New file
2017-10-04 06:23:50,582 [salt.state       ][INFO    ][23702] Completed state [/etc/keepalived/keepalived.conf] at time 06:23:50.581618 duration_in_ms=62.206
2017-10-04 06:23:50,637 [salt.state       ][INFO    ][23702] Running state [keepalived] at time 06:23:50.637299
2017-10-04 06:23:50,638 [salt.state       ][INFO    ][23702] Executing state service.running for keepalived
2017-10-04 06:23:50,639 [salt.loaded.int.module.cmdmod][INFO    ][23702] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-04 06:23:50,648 [salt.loaded.int.module.cmdmod][INFO    ][23702] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-04 06:23:50,655 [salt.loaded.int.module.cmdmod][INFO    ][23702] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-04 06:23:50,662 [salt.loaded.int.module.cmdmod][INFO    ][23702] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-04 06:23:50,669 [salt.loaded.int.module.cmdmod][INFO    ][23702] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-10-04 06:23:50,722 [salt.loaded.int.module.cmdmod][INFO    ][23702] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-04 06:23:50,730 [salt.loaded.int.module.cmdmod][INFO    ][23702] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-04 06:23:50,737 [salt.loaded.int.module.cmdmod][INFO    ][23702] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-04 06:23:50,744 [salt.state       ][INFO    ][23702] {'keepalived': True}
2017-10-04 06:23:50,744 [salt.state       ][INFO    ][23702] Completed state [keepalived] at time 06:23:50.744295 duration_in_ms=106.996
2017-10-04 06:23:50,745 [salt.minion      ][INFO    ][23702] Returning information for job: 20171004062339569994
2017-10-04 06:24:42,174 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command pillar.get with jid 20171004062442169223
2017-10-04 06:24:42,194 [salt.minion      ][INFO    ][25297] Starting a new job with PID 25297
2017-10-04 06:24:42,199 [salt.minion      ][INFO    ][25297] Returning information for job: 20171004062442169223
2017-10-04 06:30:58,868 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command state.sls with jid 20171004063058864689
2017-10-04 06:30:58,883 [salt.minion      ][INFO    ][25553] Starting a new job with PID 25553
2017-10-04 06:31:00,412 [salt.state       ][INFO    ][25553] Loading fresh modules for state activity
2017-10-04 06:31:00,436 [salt.fileclient  ][INFO    ][25553] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-04 06:31:00,460 [salt.fileclient  ][INFO    ][25553] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-04 06:31:00,744 [salt.state       ][INFO    ][25553] Running state [attr] at time 06:31:00.744336
2017-10-04 06:31:00,745 [salt.state       ][INFO    ][25553] Executing state pkg.installed for attr
2017-10-04 06:31:00,745 [salt.loaded.int.module.cmdmod][INFO    ][25553] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-04 06:31:01,006 [salt.loaded.int.module.cmdmod][INFO    ][25553] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-04 06:31:08,961 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063108954338
2017-10-04 06:31:08,976 [salt.minion      ][INFO    ][26050] Starting a new job with PID 26050
2017-10-04 06:31:08,987 [salt.minion      ][INFO    ][26050] Returning information for job: 20171004063108954338
2017-10-04 06:31:19,011 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063119004530
2017-10-04 06:31:19,027 [salt.minion      ][INFO    ][26058] Starting a new job with PID 26058
2017-10-04 06:31:19,039 [salt.minion      ][INFO    ][26058] Returning information for job: 20171004063119004530
2017-10-04 06:31:29,093 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063129058034
2017-10-04 06:31:29,109 [salt.minion      ][INFO    ][26066] Starting a new job with PID 26066
2017-10-04 06:31:29,119 [salt.minion      ][INFO    ][26066] Returning information for job: 20171004063129058034
2017-10-04 06:31:39,175 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063139161643
2017-10-04 06:31:39,191 [salt.minion      ][INFO    ][26073] Starting a new job with PID 26073
2017-10-04 06:31:39,202 [salt.minion      ][INFO    ][26073] Returning information for job: 20171004063139161643
2017-10-04 06:31:49,231 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063149224366
2017-10-04 06:31:49,248 [salt.minion      ][INFO    ][26079] Starting a new job with PID 26079
2017-10-04 06:31:49,259 [salt.minion      ][INFO    ][26079] Returning information for job: 20171004063149224366
2017-10-04 06:31:59,285 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063159278579
2017-10-04 06:31:59,302 [salt.minion      ][INFO    ][26095] Starting a new job with PID 26095
2017-10-04 06:31:59,312 [salt.minion      ][INFO    ][26095] Returning information for job: 20171004063159278579
2017-10-04 06:32:09,350 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063209344108
2017-10-04 06:32:09,367 [salt.minion      ][INFO    ][26104] Starting a new job with PID 26104
2017-10-04 06:32:09,377 [salt.minion      ][INFO    ][26104] Returning information for job: 20171004063209344108
2017-10-04 06:32:19,409 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063219401566
2017-10-04 06:32:19,426 [salt.minion      ][INFO    ][26110] Starting a new job with PID 26110
2017-10-04 06:32:19,435 [salt.minion      ][INFO    ][26110] Returning information for job: 20171004063219401566
2017-10-04 06:32:29,476 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063229470213
2017-10-04 06:32:29,494 [salt.minion      ][INFO    ][26116] Starting a new job with PID 26116
2017-10-04 06:32:29,503 [salt.minion      ][INFO    ][26116] Returning information for job: 20171004063229470213
2017-10-04 06:32:39,598 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063239591558
2017-10-04 06:32:39,615 [salt.minion      ][INFO    ][26126] Starting a new job with PID 26126
2017-10-04 06:32:39,625 [salt.minion      ][INFO    ][26126] Returning information for job: 20171004063239591558
2017-10-04 06:32:49,664 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063249657779
2017-10-04 06:32:49,680 [salt.minion      ][INFO    ][26134] Starting a new job with PID 26134
2017-10-04 06:32:49,690 [salt.minion      ][INFO    ][26134] Returning information for job: 20171004063249657779
2017-10-04 06:32:59,733 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063259726597
2017-10-04 06:32:59,749 [salt.minion      ][INFO    ][26141] Starting a new job with PID 26141
2017-10-04 06:32:59,760 [salt.minion      ][INFO    ][26141] Returning information for job: 20171004063259726597
2017-10-04 06:33:09,806 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063309800472
2017-10-04 06:33:09,823 [salt.minion      ][INFO    ][26149] Starting a new job with PID 26149
2017-10-04 06:33:09,833 [salt.minion      ][INFO    ][26149] Returning information for job: 20171004063309800472
2017-10-04 06:33:19,880 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063319873632
2017-10-04 06:33:19,896 [salt.minion      ][INFO    ][26155] Starting a new job with PID 26155
2017-10-04 06:33:19,906 [salt.minion      ][INFO    ][26155] Returning information for job: 20171004063319873632
2017-10-04 06:33:29,905 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063329893195
2017-10-04 06:33:29,921 [salt.minion      ][INFO    ][26161] Starting a new job with PID 26161
2017-10-04 06:33:29,931 [salt.minion      ][INFO    ][26161] Returning information for job: 20171004063329893195
2017-10-04 06:33:39,931 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063339925279
2017-10-04 06:33:39,947 [salt.minion      ][INFO    ][26169] Starting a new job with PID 26169
2017-10-04 06:33:39,957 [salt.minion      ][INFO    ][26169] Returning information for job: 20171004063339925279
2017-10-04 06:33:49,984 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063349978209
2017-10-04 06:33:50,001 [salt.minion      ][INFO    ][26175] Starting a new job with PID 26175
2017-10-04 06:33:50,010 [salt.minion      ][INFO    ][26175] Returning information for job: 20171004063349978209
2017-10-04 06:34:00,007 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063400000942
2017-10-04 06:34:00,024 [salt.minion      ][INFO    ][26181] Starting a new job with PID 26181
2017-10-04 06:34:00,035 [salt.minion      ][INFO    ][26181] Returning information for job: 20171004063400000942
2017-10-04 06:34:10,114 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063410107898
2017-10-04 06:34:10,130 [salt.minion      ][INFO    ][26189] Starting a new job with PID 26189
2017-10-04 06:34:10,140 [salt.minion      ][INFO    ][26189] Returning information for job: 20171004063410107898
2017-10-04 06:34:13,828 [salt.loaded.int.module.cmdmod][INFO    ][25553] 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-10-04 06:34:16,338 [salt.loaded.int.module.cmdmod][INFO    ][25553] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-04 06:34:16,362 [salt.state       ][INFO    ][25553] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-10-04 06:34:16,370 [salt.state       ][INFO    ][25553] Loading fresh modules for state activity
2017-10-04 06:34:16,381 [salt.state       ][INFO    ][25553] Completed state [attr] at time 06:34:16.381148 duration_in_ms=195636.813
2017-10-04 06:34:16,386 [salt.state       ][INFO    ][25553] Running state [glusterfs-server] at time 06:34:16.385891
2017-10-04 06:34:16,386 [salt.state       ][INFO    ][25553] Executing state pkg.installed for glusterfs-server
2017-10-04 06:34:16,561 [salt.loaded.int.module.cmdmod][INFO    ][25553] 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-10-04 06:34:20,338 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063420331145
2017-10-04 06:34:20,353 [salt.minion      ][INFO    ][26760] Starting a new job with PID 26760
2017-10-04 06:34:20,365 [salt.minion      ][INFO    ][26760] Returning information for job: 20171004063420331145
2017-10-04 06:34:30,565 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063430558312
2017-10-04 06:34:30,579 [salt.minion      ][INFO    ][29603] Starting a new job with PID 29603
2017-10-04 06:34:30,589 [salt.minion      ][INFO    ][29603] Returning information for job: 20171004063430558312
2017-10-04 06:34:33,522 [salt.loaded.int.module.cmdmod][INFO    ][25553] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-04 06:34:33,546 [salt.state       ][INFO    ][25553] 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-10-04 06:34:33,553 [salt.state       ][INFO    ][25553] Loading fresh modules for state activity
2017-10-04 06:34:33,564 [salt.state       ][INFO    ][25553] Completed state [glusterfs-server] at time 06:34:33.564126 duration_in_ms=17178.235
2017-10-04 06:34:33,568 [salt.state       ][INFO    ][25553] Running state [bc] at time 06:34:33.567867
2017-10-04 06:34:33,568 [salt.state       ][INFO    ][25553] Executing state pkg.installed for bc
2017-10-04 06:34:33,825 [salt.loaded.int.module.cmdmod][INFO    ][25553] 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-10-04 06:34:36,663 [salt.loaded.int.module.cmdmod][INFO    ][25553] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-04 06:34:36,689 [salt.state       ][INFO    ][25553] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-10-04 06:34:36,698 [salt.state       ][INFO    ][25553] Loading fresh modules for state activity
2017-10-04 06:34:36,710 [salt.state       ][INFO    ][25553] Completed state [bc] at time 06:34:36.710052 duration_in_ms=3142.185
2017-10-04 06:34:36,771 [salt.state       ][INFO    ][25553] Running state [glusterfs-server] at time 06:34:36.771246
2017-10-04 06:34:36,772 [salt.state       ][INFO    ][25553] Executing state service.running for glusterfs-server
2017-10-04 06:34:36,773 [salt.loaded.int.module.cmdmod][INFO    ][25553] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-04 06:34:36,784 [salt.loaded.int.module.cmdmod][INFO    ][25553] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-04 06:34:36,792 [salt.loaded.int.module.cmdmod][INFO    ][25553] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-04 06:34:36,802 [salt.state       ][INFO    ][25553] The service glusterfs-server is already running
2017-10-04 06:34:36,802 [salt.state       ][INFO    ][25553] Completed state [glusterfs-server] at time 06:34:36.802447 duration_in_ms=31.201
2017-10-04 06:34:36,804 [salt.state       ][INFO    ][25553] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:34:36.803910
2017-10-04 06:34:36,804 [salt.state       ][INFO    ][25553] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-04 06:34:36,819 [salt.state       ][INFO    ][25553] File changed:
New file
2017-10-04 06:34:36,819 [salt.state       ][INFO    ][25553] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:34:36.818672 duration_in_ms=14.762
2017-10-04 06:34:36,819 [salt.state       ][INFO    ][25553] Running state [/srv/glusterfs/glance] at time 06:34:36.818844
2017-10-04 06:34:36,819 [salt.state       ][INFO    ][25553] Executing state file.directory for /srv/glusterfs/glance
2017-10-04 06:34:36,820 [salt.state       ][INFO    ][25553] {'/srv/glusterfs/glance': 'New Dir'}
2017-10-04 06:34:36,820 [salt.state       ][INFO    ][25553] Completed state [/srv/glusterfs/glance] at time 06:34:36.819695 duration_in_ms=0.851
2017-10-04 06:34:36,820 [salt.state       ][INFO    ][25553] Running state [/srv/glusterfs/keystone-keys] at time 06:34:36.819840
2017-10-04 06:34:36,820 [salt.state       ][INFO    ][25553] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-04 06:34:36,820 [salt.state       ][INFO    ][25553] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-10-04 06:34:36,821 [salt.state       ][INFO    ][25553] Completed state [/srv/glusterfs/keystone-keys] at time 06:34:36.820476 duration_in_ms=0.636
2017-10-04 06:34:36,821 [salt.state       ][INFO    ][25553] Running state [/srv/glusterfs/nova_instances] at time 06:34:36.820618
2017-10-04 06:34:36,821 [salt.state       ][INFO    ][25553] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-04 06:34:36,821 [salt.state       ][INFO    ][25553] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-10-04 06:34:36,821 [salt.state       ][INFO    ][25553] Completed state [/srv/glusterfs/nova_instances] at time 06:34:36.821251 duration_in_ms=0.632
2017-10-04 06:34:36,821 [salt.state       ][INFO    ][25553] Running state [/srv/glusterfs/keystone-credential-keys] at time 06:34:36.821396
2017-10-04 06:34:36,822 [salt.state       ][INFO    ][25553] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-04 06:34:36,822 [salt.state       ][INFO    ][25553] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-10-04 06:34:36,822 [salt.state       ][INFO    ][25553] Completed state [/srv/glusterfs/keystone-credential-keys] at time 06:34:36.822029 duration_in_ms=0.633
2017-10-04 06:34:36,823 [salt.minion      ][INFO    ][25553] Returning information for job: 20171004063058864689
2017-10-04 06:34:38,000 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command test.ping with jid 20171004063437995581
2017-10-04 06:34:38,015 [salt.minion      ][INFO    ][30417] Starting a new job with PID 30417
2017-10-04 06:34:38,042 [salt.minion      ][INFO    ][30417] Returning information for job: 20171004063437995581
2017-10-04 06:34:38,213 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command state.sls with jid 20171004063438208032
2017-10-04 06:34:38,228 [salt.minion      ][INFO    ][30422] Starting a new job with PID 30422
2017-10-04 06:34:39,621 [salt.state       ][INFO    ][30422] Loading fresh modules for state activity
2017-10-04 06:34:39,642 [salt.fileclient  ][INFO    ][30422] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-04 06:34:39,672 [salt.fileclient  ][INFO    ][30422] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-04 06:34:39,735 [salt.fileclient  ][INFO    ][30422] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-04 06:34:39,753 [salt.fileclient  ][INFO    ][30422] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-04 06:34:40,001 [salt.state       ][INFO    ][30422] Running state [attr] at time 06:34:40.001465
2017-10-04 06:34:40,002 [salt.state       ][INFO    ][30422] Executing state pkg.installed for attr
2017-10-04 06:34:40,002 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-04 06:34:40,241 [salt.state       ][INFO    ][30422] Package attr is already installed
2017-10-04 06:34:40,241 [salt.state       ][INFO    ][30422] Completed state [attr] at time 06:34:40.240932 duration_in_ms=239.467
2017-10-04 06:34:40,241 [salt.state       ][INFO    ][30422] Running state [glusterfs-server] at time 06:34:40.241141
2017-10-04 06:34:40,241 [salt.state       ][INFO    ][30422] Executing state pkg.installed for glusterfs-server
2017-10-04 06:34:40,244 [salt.state       ][INFO    ][30422] Package glusterfs-server is already installed
2017-10-04 06:34:40,244 [salt.state       ][INFO    ][30422] Completed state [glusterfs-server] at time 06:34:40.243959 duration_in_ms=2.818
2017-10-04 06:34:40,244 [salt.state       ][INFO    ][30422] Running state [bc] at time 06:34:40.244099
2017-10-04 06:34:40,244 [salt.state       ][INFO    ][30422] Executing state pkg.installed for bc
2017-10-04 06:34:40,247 [salt.state       ][INFO    ][30422] Package bc is already installed
2017-10-04 06:34:40,247 [salt.state       ][INFO    ][30422] Completed state [bc] at time 06:34:40.246886 duration_in_ms=2.787
2017-10-04 06:34:40,248 [salt.state       ][INFO    ][30422] Running state [glusterfs-server] at time 06:34:40.247631
2017-10-04 06:34:40,248 [salt.state       ][INFO    ][30422] Executing state service.running for glusterfs-server
2017-10-04 06:34:40,248 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-04 06:34:40,257 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-10-04 06:34:40,296 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-04 06:34:40,310 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-04 06:34:40,317 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-04 06:34:40,325 [salt.state       ][INFO    ][30422] The service glusterfs-server is already running
2017-10-04 06:34:40,326 [salt.state       ][INFO    ][30422] Completed state [glusterfs-server] at time 06:34:40.325520 duration_in_ms=77.888
2017-10-04 06:34:40,327 [salt.state       ][INFO    ][30422] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:34:40.326896
2017-10-04 06:34:40,327 [salt.state       ][INFO    ][30422] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-04 06:34:40,340 [salt.state       ][INFO    ][30422] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-04 06:34:40,340 [salt.state       ][INFO    ][30422] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:34:40.339711 duration_in_ms=12.815
2017-10-04 06:34:40,340 [salt.state       ][INFO    ][30422] Running state [/srv/glusterfs/glance] at time 06:34:40.339884
2017-10-04 06:34:40,340 [salt.state       ][INFO    ][30422] Executing state file.directory for /srv/glusterfs/glance
2017-10-04 06:34:40,340 [salt.state       ][INFO    ][30422] Directory /srv/glusterfs/glance is in the correct state
2017-10-04 06:34:40,341 [salt.state       ][INFO    ][30422] Completed state [/srv/glusterfs/glance] at time 06:34:40.340479 duration_in_ms=0.595
2017-10-04 06:34:40,341 [salt.state       ][INFO    ][30422] Running state [/srv/glusterfs/keystone-keys] at time 06:34:40.340617
2017-10-04 06:34:40,341 [salt.state       ][INFO    ][30422] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-04 06:34:40,341 [salt.state       ][INFO    ][30422] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-04 06:34:40,341 [salt.state       ][INFO    ][30422] Completed state [/srv/glusterfs/keystone-keys] at time 06:34:40.341156 duration_in_ms=0.54
2017-10-04 06:34:40,341 [salt.state       ][INFO    ][30422] Running state [/srv/glusterfs/nova_instances] at time 06:34:40.341293
2017-10-04 06:34:40,341 [salt.state       ][INFO    ][30422] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-04 06:34:40,342 [salt.state       ][INFO    ][30422] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-04 06:34:40,342 [salt.state       ][INFO    ][30422] Completed state [/srv/glusterfs/nova_instances] at time 06:34:40.341854 duration_in_ms=0.561
2017-10-04 06:34:40,342 [salt.state       ][INFO    ][30422] Running state [/srv/glusterfs/keystone-credential-keys] at time 06:34:40.341990
2017-10-04 06:34:40,342 [salt.state       ][INFO    ][30422] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-04 06:34:40,342 [salt.state       ][INFO    ][30422] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-04 06:34:40,343 [salt.state       ][INFO    ][30422] Completed state [/srv/glusterfs/keystone-credential-keys] at time 06:34:40.342563 duration_in_ms=0.572
2017-10-04 06:34:40,393 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command ['git', '--version'] in directory '/root'
2017-10-04 06:34:40,478 [salt.state       ][INFO    ][30422] Running state [sleep 5] at time 06:34:40.477677
2017-10-04 06:34:40,478 [salt.state       ][INFO    ][30422] Executing state cmd.wait for sleep 5
2017-10-04 06:34:40,478 [salt.state       ][INFO    ][30422] No changes made for sleep 5
2017-10-04 06:34:40,478 [salt.state       ][INFO    ][30422] Completed state [sleep 5] at time 06:34:40.478186 duration_in_ms=0.511
2017-10-04 06:34:40,479 [salt.state       ][INFO    ][30422] Running state [10.167.4.141] at time 06:34:40.478567
2017-10-04 06:34:40,479 [salt.state       ][INFO    ][30422] Executing state glusterfs.peered for 10.167.4.141
2017-10-04 06:34:40,479 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:40,488 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:40,537 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:40,546 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:40,895 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:40,907 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:40,964 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:40,974 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:41,041 [salt.state       ][INFO    ][30422] {'new': {'10.167.4.141': []}, 'old': None}
2017-10-04 06:34:41,041 [salt.state       ][INFO    ][30422] Completed state [10.167.4.141] at time 06:34:41.040962 duration_in_ms=562.394
2017-10-04 06:34:41,043 [salt.state       ][INFO    ][30422] Running state [10.167.4.142] at time 06:34:41.043301
2017-10-04 06:34:41,044 [salt.state       ][INFO    ][30422] Executing state glusterfs.peered for 10.167.4.142
2017-10-04 06:34:41,044 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:41,055 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:41,198 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:41,209 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:41,544 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:41,556 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:41,617 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:41,627 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:41,679 [salt.state       ][INFO    ][30422] {'new': {'10.167.4.141': [], '10.167.4.142': []}, 'old': {'10.167.4.141': []}}
2017-10-04 06:34:41,680 [salt.state       ][INFO    ][30422] Completed state [10.167.4.142] at time 06:34:41.679498 duration_in_ms=636.197
2017-10-04 06:34:41,682 [salt.state       ][INFO    ][30422] Running state [10.167.4.143] at time 06:34:41.681793
2017-10-04 06:34:41,682 [salt.state       ][INFO    ][30422] Executing state glusterfs.peered for 10.167.4.143
2017-10-04 06:34:41,683 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:41,692 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:41,827 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:41,837 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:41,893 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:41,903 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:41,956 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:41,967 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:42,022 [salt.state       ][INFO    ][30422] Peering with localhost is not needed
2017-10-04 06:34:42,022 [salt.state       ][INFO    ][30422] Completed state [10.167.4.143] at time 06:34:42.021914 duration_in_ms=340.121
2017-10-04 06:34:42,023 [salt.state       ][INFO    ][30422] Running state [glance] at time 06:34:42.022756
2017-10-04 06:34:42,023 [salt.state       ][INFO    ][30422] Executing state glusterfs.created for glance
2017-10-04 06:34:42,023 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:42,034 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:42,099 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:42,108 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:42,846 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:42,858 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:44,078 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:44,091 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:44,146 [salt.state       ][INFO    ][30422] {'new': ['glance'], 'old': []}
2017-10-04 06:34:44,146 [salt.state       ][INFO    ][30422] Completed state [glance] at time 06:34:44.145996 duration_in_ms=2123.24
2017-10-04 06:34:44,149 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 06:34:44.149262
2017-10-04 06:34:44,150 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-04 06:34:44,150 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-04 06:34:44,202 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-04 06:34:44,955 [salt.state       ][INFO    ][30422] {'pid': 30643, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:34:44,955 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 06:34:44.954813 duration_in_ms=805.55
2017-10-04 06:34:44,955 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 06:34:44.955368
2017-10-04 06:34:44,956 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-04 06:34:44,956 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-04 06:34:45,010 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-10-04 06:34:45,704 [salt.state       ][INFO    ][30422] {'pid': 30662, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:34:45,704 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 06:34:45.704378 duration_in_ms=749.009
2017-10-04 06:34:45,705 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 06:34:45.704954
2017-10-04 06:34:45,705 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-04 06:34:45,706 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-04 06:34:45,763 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-10-04 06:34:48,256 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063448250315
2017-10-04 06:34:48,272 [salt.minion      ][INFO    ][30690] Starting a new job with PID 30690
2017-10-04 06:34:48,283 [salt.minion      ][INFO    ][30690] Returning information for job: 20171004063448250315
2017-10-04 06:34:48,477 [salt.state       ][INFO    ][30422] {'pid': 30679, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:34:48,477 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 06:34:48.477123 duration_in_ms=2772.168
2017-10-04 06:34:48,478 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 06:34:48.477620
2017-10-04 06:34:48,478 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-04 06:34:48,478 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-04 06:34:48,532 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-04 06:34:49,268 [salt.state       ][INFO    ][30422] {'pid': 30705, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:34:49,269 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 06:34:49.268715 duration_in_ms=791.094
2017-10-04 06:34:49,269 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 06:34:49.269257
2017-10-04 06:34:49,270 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-04 06:34:49,270 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-04 06:34:49,327 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-10-04 06:34:50,028 [salt.state       ][INFO    ][30422] {'pid': 30722, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:34:50,029 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 06:34:50.028775 duration_in_ms=759.518
2017-10-04 06:34:50,030 [salt.state       ][INFO    ][30422] Running state [glance] at time 06:34:50.029834
2017-10-04 06:34:50,030 [salt.state       ][INFO    ][30422] Executing state glusterfs.started for glance
2017-10-04 06:34:50,031 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:50,042 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:50,098 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:50,109 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:50,167 [salt.state       ][INFO    ][30422] Volume glance is already started
2017-10-04 06:34:50,167 [salt.state       ][INFO    ][30422] Completed state [glance] at time 06:34:50.167249 duration_in_ms=137.415
2017-10-04 06:34:50,168 [salt.state       ][INFO    ][30422] Running state [keystone-keys] at time 06:34:50.168119
2017-10-04 06:34:50,168 [salt.state       ][INFO    ][30422] Executing state glusterfs.created for keystone-keys
2017-10-04 06:34:50,169 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:50,179 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:50,230 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:50,241 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:50,986 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:50,999 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:53,908 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:53,921 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:53,975 [salt.state       ][INFO    ][30422] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-10-04 06:34:53,975 [salt.state       ][INFO    ][30422] Completed state [keystone-keys] at time 06:34:53.974787 duration_in_ms=3806.668
2017-10-04 06:34:53,978 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 06:34:53.977627
2017-10-04 06:34:53,978 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-04 06:34:53,978 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-04 06:34:54,031 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-10-04 06:34:54,711 [salt.state       ][INFO    ][30422] {'pid': 30832, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:34:54,711 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 06:34:54.711286 duration_in_ms=733.658
2017-10-04 06:34:54,712 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:34:54.711860
2017-10-04 06:34:54,712 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-04 06:34:54,713 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-04 06:34:54,769 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-04 06:34:55,463 [salt.state       ][INFO    ][30422] {'pid': 30849, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:34:55,463 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:34:55.462947 duration_in_ms=751.086
2017-10-04 06:34:55,464 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:34:55.463522
2017-10-04 06:34:55,464 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-04 06:34:55,464 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-04 06:34:55,522 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-04 06:34:56,224 [salt.state       ][INFO    ][30422] {'pid': 30867, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:34:56,224 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:34:56.224344 duration_in_ms=760.821
2017-10-04 06:34:56,225 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 06:34:56.224940
2017-10-04 06:34:56,225 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-04 06:34:56,226 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-04 06:34:56,284 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-10-04 06:34:58,395 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063458388484
2017-10-04 06:34:58,411 [salt.minion      ][INFO    ][30899] Starting a new job with PID 30899
2017-10-04 06:34:58,421 [salt.minion      ][INFO    ][30899] Returning information for job: 20171004063458388484
2017-10-04 06:34:58,948 [salt.state       ][INFO    ][30422] {'pid': 30886, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:34:58,948 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 06:34:58.948279 duration_in_ms=2723.339
2017-10-04 06:34:58,949 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 06:34:58.948871
2017-10-04 06:34:58,949 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-04 06:34:58,950 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-04 06:34:59,007 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-10-04 06:34:59,632 [salt.state       ][INFO    ][30422] {'pid': 30911, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:34:59,632 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 06:34:59.632357 duration_in_ms=683.486
2017-10-04 06:34:59,633 [salt.state       ][INFO    ][30422] Running state [keystone-keys] at time 06:34:59.633405
2017-10-04 06:34:59,634 [salt.state       ][INFO    ][30422] Executing state glusterfs.started for keystone-keys
2017-10-04 06:34:59,634 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:59,646 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:59,699 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:59,709 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:59,772 [salt.state       ][INFO    ][30422] Volume keystone-keys is already started
2017-10-04 06:34:59,773 [salt.state       ][INFO    ][30422] Completed state [keystone-keys] at time 06:34:59.772800 duration_in_ms=139.394
2017-10-04 06:34:59,775 [salt.state       ][INFO    ][30422] Running state [nova_instances] at time 06:34:59.774561
2017-10-04 06:34:59,775 [salt.state       ][INFO    ][30422] Executing state glusterfs.created for nova_instances
2017-10-04 06:34:59,776 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:59,787 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:34:59,841 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:34:59,851 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:35:00,623 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:35:00,636 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:35:03,563 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:35:03,575 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:35:03,630 [salt.state       ][INFO    ][30422] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-10-04 06:35:03,630 [salt.state       ][INFO    ][30422] Completed state [nova_instances] at time 06:35:03.630076 duration_in_ms=3855.514
2017-10-04 06:35:03,634 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 06:35:03.633759
2017-10-04 06:35:03,634 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-04 06:35:03,635 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-04 06:35:03,691 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-04 06:35:04,381 [salt.state       ][INFO    ][30422] {'pid': 31023, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:35:04,381 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 06:35:04.381005 duration_in_ms=747.245
2017-10-04 06:35:04,382 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 06:35:04.381579
2017-10-04 06:35:04,382 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-04 06:35:04,382 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-04 06:35:04,441 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'' in directory '/root'
2017-10-04 06:35:05,171 [salt.state       ][INFO    ][30422] {'pid': 31041, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:35:05,171 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 06:35:05.170916 duration_in_ms=789.336
2017-10-04 06:35:05,172 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 06:35:05.171609
2017-10-04 06:35:05,172 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-04 06:35:05,173 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-04 06:35:05,229 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'On'' in directory '/root'
2017-10-04 06:35:05,931 [salt.state       ][INFO    ][30422] {'pid': 31058, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:35:05,931 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 06:35:05.930886 duration_in_ms=759.278
2017-10-04 06:35:05,932 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 06:35:05.931817
2017-10-04 06:35:05,932 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-04 06:35:05,933 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-04 06:35:05,991 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'On'' in directory '/root'
2017-10-04 06:35:08,537 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063508531157
2017-10-04 06:35:08,553 [salt.minion      ][INFO    ][31089] Starting a new job with PID 31089
2017-10-04 06:35:08,564 [salt.minion      ][INFO    ][31089] Returning information for job: 20171004063508531157
2017-10-04 06:35:08,708 [salt.state       ][INFO    ][30422] {'pid': 31075, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:35:08,708 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 06:35:08.707974 duration_in_ms=2776.158
2017-10-04 06:35:08,709 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 06:35:08.708561
2017-10-04 06:35:08,709 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-04 06:35:08,709 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-04 06:35:08,766 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-04 06:35:09,404 [salt.state       ][INFO    ][30422] {'pid': 31101, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:35:09,404 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 06:35:09.404156 duration_in_ms=695.594
2017-10-04 06:35:09,405 [salt.state       ][INFO    ][30422] Running state [nova_instances] at time 06:35:09.405310
2017-10-04 06:35:09,406 [salt.state       ][INFO    ][30422] Executing state glusterfs.started for nova_instances
2017-10-04 06:35:09,406 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:35:09,418 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:35:09,472 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:35:09,482 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:35:09,537 [salt.state       ][INFO    ][30422] Volume nova_instances is already started
2017-10-04 06:35:09,538 [salt.state       ][INFO    ][30422] Completed state [nova_instances] at time 06:35:09.537522 duration_in_ms=132.211
2017-10-04 06:35:09,539 [salt.state       ][INFO    ][30422] Running state [keystone-credential-keys] at time 06:35:09.538500
2017-10-04 06:35:09,539 [salt.state       ][INFO    ][30422] Executing state glusterfs.created for keystone-credential-keys
2017-10-04 06:35:09,539 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:35:09,549 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:35:09,599 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:35:09,608 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:35:10,376 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:35:10,389 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:35:13,333 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:35:13,345 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:35:13,398 [salt.state       ][INFO    ][30422] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-10-04 06:35:13,399 [salt.state       ][INFO    ][30422] Completed state [keystone-credential-keys] at time 06:35:13.398624 duration_in_ms=3860.123
2017-10-04 06:35:13,402 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 06:35:13.401823
2017-10-04 06:35:13,402 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-04 06:35:13,403 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-04 06:35:13,455 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-10-04 06:35:14,104 [salt.state       ][INFO    ][30422] {'pid': 31217, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:35:14,105 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 06:35:14.104577 duration_in_ms=702.753
2017-10-04 06:35:14,105 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:35:14.105149
2017-10-04 06:35:14,105 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-04 06:35:14,106 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-04 06:35:14,159 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-04 06:35:14,937 [salt.state       ][INFO    ][30422] {'pid': 31234, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:35:14,937 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:35:14.937101 duration_in_ms=831.952
2017-10-04 06:35:14,938 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 06:35:14.937684
2017-10-04 06:35:14,938 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-04 06:35:14,939 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-04 06:35:14,994 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-10-04 06:35:17,699 [salt.state       ][INFO    ][30422] {'pid': 31252, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:35:17,699 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 06:35:17.698928 duration_in_ms=2761.243
2017-10-04 06:35:17,700 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:35:17.699510
2017-10-04 06:35:17,700 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-04 06:35:17,700 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-04 06:35:17,758 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-04 06:35:18,447 [salt.state       ][INFO    ][30422] {'pid': 31273, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:35:18,447 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:35:18.447395 duration_in_ms=747.883
2017-10-04 06:35:18,448 [salt.state       ][INFO    ][30422] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 06:35:18.447969
2017-10-04 06:35:18,448 [salt.state       ][INFO    ][30422] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-04 06:35:18,449 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-04 06:35:18,505 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-10-04 06:35:18,680 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command saltutil.find_job with jid 20171004063518674208
2017-10-04 06:35:18,695 [salt.minion      ][INFO    ][31300] Starting a new job with PID 31300
2017-10-04 06:35:18,707 [salt.minion      ][INFO    ][31300] Returning information for job: 20171004063518674208
2017-10-04 06:35:19,246 [salt.state       ][INFO    ][30422] {'pid': 31290, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-04 06:35:19,247 [salt.state       ][INFO    ][30422] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 06:35:19.246611 duration_in_ms=798.642
2017-10-04 06:35:19,248 [salt.state       ][INFO    ][30422] Running state [keystone-credential-keys] at time 06:35:19.247644
2017-10-04 06:35:19,248 [salt.state       ][INFO    ][30422] Executing state glusterfs.started for keystone-credential-keys
2017-10-04 06:35:19,248 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:35:19,259 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:35:19,306 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --version' in directory '/root'
2017-10-04 06:35:19,314 [salt.loaded.int.module.cmdmod][INFO    ][30422] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-04 06:35:19,366 [salt.state       ][INFO    ][30422] Volume keystone-credential-keys is already started
2017-10-04 06:35:19,366 [salt.state       ][INFO    ][30422] Completed state [keystone-credential-keys] at time 06:35:19.366175 duration_in_ms=118.529
2017-10-04 06:35:19,369 [salt.minion      ][INFO    ][30422] Returning information for job: 20171004063438208032
2017-10-04 06:35:36,099 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command test.ping with jid 20171004063536093118
2017-10-04 06:35:36,115 [salt.minion      ][INFO    ][31328] Starting a new job with PID 31328
2017-10-04 06:35:36,139 [salt.minion      ][INFO    ][31328] Returning information for job: 20171004063536093118
2017-10-04 06:35:36,309 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command cmd.run with jid 20171004063536303470
2017-10-04 06:35:36,324 [salt.minion      ][INFO    ][31333] Starting a new job with PID 31333
2017-10-04 06:35:36,328 [salt.loaded.int.module.cmdmod][INFO    ][31333] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-04 06:35:36,445 [salt.minion      ][INFO    ][31333] Returning information for job: 20171004063536303470
2017-10-04 07:07:07,511 [salt.utils.schedule][INFO    ][23002] Running scheduled job: __mine_interval
2017-10-04 07:59:36,340 [salt.minion      ][INFO    ][23002] User sudo_ubuntu Executing command cp.push_dir with jid 20171004075936331960
2017-10-04 07:59:36,357 [salt.minion      ][INFO    ][32398] Starting a new job with PID 32398
