2017-12-02 10:46:13,253 [salt.cli.daemons ][WARNING ][2017] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-02 10:46:40,323 [salt.state       ][ERROR   ][3643] No contents found in top file
2017-12-02 10:48:28,254 [salt.utils.parsers][WARNING ][2017] Minion received a SIGTERM. Exiting.
2017-12-02 10:52:57,176 [salt.cli.daemons ][WARNING ][3247] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-02 10:55:18,342 [py.warnings      ][WARNING ][14413] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-12-02 10:59:52,043 [salt.loaded.int.module.cmdmod][ERROR   ][14413] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-02 10:59:52,043 [salt.loaded.int.module.cmdmod][ERROR   ][14413] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-02 10:59:56,573 [salt.loaded.int.module.cmdmod][ERROR   ][14413] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-02 10:59:56,574 [salt.loaded.int.module.cmdmod][ERROR   ][14413] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-02 11:00:01,021 [salt.loaded.int.module.cmdmod][ERROR   ][14413] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-02 11:00:01,021 [salt.loaded.int.module.cmdmod][ERROR   ][14413] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-02 11:00:05,939 [salt.loaded.int.module.cmdmod][ERROR   ][14413] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-02 11:00:05,939 [salt.loaded.int.module.cmdmod][ERROR   ][14413] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-02 11:00:10,437 [salt.loaded.int.module.cmdmod][ERROR   ][14413] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-02 11:00:10,438 [salt.loaded.int.module.cmdmod][ERROR   ][14413] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-02 11:00:14,908 [salt.loaded.int.module.cmdmod][ERROR   ][14413] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-02 11:00:14,909 [salt.loaded.int.module.cmdmod][ERROR   ][14413] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-02 11:00:18,407 [salt.loaded.int.module.cmdmod][ERROR   ][14413] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-12-02 11:00:20,946 [salt.loaded.int.module.cmdmod][INFO    ][22335] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-02 11:00:20,954 [salt.loaded.int.module.cmdmod][INFO    ][22335] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-02 11:00:20,965 [salt.loaded.int.module.cmdmod][INFO    ][22335] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-02 11:00:20,974 [salt.utils.parsers][WARNING ][3247] Minion received a SIGTERM. Exiting.
2017-12-02 11:00:21,286 [salt.cli.daemons ][INFO    ][22411] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-odl-ha.local"
2017-12-02 11:00:22,002 [salt.minion      ][INFO    ][22411] Creating minion process manager
2017-12-02 11:00:22,002 [salt.cli.daemons ][WARNING ][22411] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-02 11:00:22,002 [salt.cli.daemons ][INFO    ][22411] The Salt Minion is starting up
2017-12-02 11:00:22,002 [salt.minion      ][INFO    ][22411] Minion is starting as user 'root'
2017-12-02 11:00:22,003 [salt.utils.event ][INFO    ][22411] Starting pull socket on /var/run/salt/minion/minion_event_2d6d7b82d1_pull.ipc
2017-12-02 11:00:23,155 [salt.loaded.int.module.cmdmod][INFO    ][22411] Executing command ['date', '+%z'] in directory '/root'
2017-12-02 11:00:23,168 [salt.utils.schedule][INFO    ][22411] Updating job settings for scheduled job: __mine_interval
2017-12-02 11:00:23,172 [salt.minion      ][INFO    ][22411] Added mine.update to scheduler
2017-12-02 11:00:23,199 [salt.minion      ][INFO    ][22411] Minion is ready to receive requests!
2017-12-02 11:00:24,201 [salt.utils.schedule][INFO    ][22411] Running scheduled job: __mine_interval
2017-12-02 11:02:29,157 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171202110229129092
2017-12-02 11:02:29,168 [salt.minion      ][INFO    ][22551] Starting a new job with PID 22551
2017-12-02 11:02:31,521 [salt.state       ][INFO    ][22551] Loading fresh modules for state activity
2017-12-02 11:02:31,549 [salt.state       ][ERROR   ][22551] No contents found in top file
2017-12-02 11:02:31,549 [salt.utils.extmods][INFO    ][22551] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-02 11:02:31,552 [salt.utils.extmods][INFO    ][22551] Syncing beacons for environment 'base'
2017-12-02 11:02:31,553 [salt.utils.extmods][INFO    ][22551] Loading cache from salt://_beacons, for base)
2017-12-02 11:02:31,553 [salt.fileclient  ][INFO    ][22551] Caching directory '_beacons/' for environment 'base'
2017-12-02 11:02:31,586 [salt.utils.extmods][INFO    ][22551] Syncing modules for environment 'base'
2017-12-02 11:02:31,586 [salt.utils.extmods][INFO    ][22551] Loading cache from salt://_modules, for base)
2017-12-02 11:02:31,586 [salt.fileclient  ][INFO    ][22551] Caching directory '_modules/' for environment 'base'
2017-12-02 11:02:31,627 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-02 11:02:31,637 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-02 11:02:31,649 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-02 11:02:31,664 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-02 11:02:31,675 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-02 11:02:31,685 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-02 11:02:31,695 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-02 11:02:31,706 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-02 11:02:31,719 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-02 11:02:31,824 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-02 11:02:31,836 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-02 11:02:31,850 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-02 11:02:31,862 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-02 11:02:31,881 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-02 11:02:31,891 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-02 11:02:31,907 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-02 11:02:31,920 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-02 11:02:31,933 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-02 11:02:31,947 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-02 11:02:31,959 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-02 11:02:31,970 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-02 11:02:31,984 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-02 11:02:32,002 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-02 11:02:32,014 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-02 11:02:32,025 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-02 11:02:32,035 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-02 11:02:32,047 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-02 11:02:32,058 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-02 11:02:32,069 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-02 11:02:32,088 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-02 11:02:32,098 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-02 11:02:32,109 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-02 11:02:32,120 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-02 11:02:32,133 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-02 11:02:32,137 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-02 11:02:32,137 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-02 11:02:32,138 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-02 11:02:32,138 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-02 11:02:32,138 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-02 11:02:32,139 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-02 11:02:32,139 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-02 11:02:32,139 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-02 11:02:32,139 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-02 11:02:32,140 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-02 11:02:32,140 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-02 11:02:32,140 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-02 11:02:32,140 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-02 11:02:32,141 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-02 11:02:32,141 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-02 11:02:32,141 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-02 11:02:32,141 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-02 11:02:32,142 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-02 11:02:32,142 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-02 11:02:32,142 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-02 11:02:32,142 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-02 11:02:32,143 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-02 11:02:32,143 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-02 11:02:32,143 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-02 11:02:32,144 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-02 11:02:32,144 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-02 11:02:32,144 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-02 11:02:32,144 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-02 11:02:32,145 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-02 11:02:32,145 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-02 11:02:32,145 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-02 11:02:32,145 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-02 11:02:32,146 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-02 11:02:32,146 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-12-02 11:02:32,146 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-02 11:02:32,146 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-02 11:02:32,152 [salt.utils.extmods][INFO    ][22551] Syncing states for environment 'base'
2017-12-02 11:02:32,152 [salt.utils.extmods][INFO    ][22551] Loading cache from salt://_states, for base)
2017-12-02 11:02:32,152 [salt.fileclient  ][INFO    ][22551] Caching directory '_states/' for environment 'base'
2017-12-02 11:02:32,204 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-02 11:02:32,216 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-02 11:02:32,227 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-02 11:02:32,238 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-02 11:02:32,251 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-02 11:02:32,263 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-02 11:02:32,275 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-02 11:02:32,287 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-02 11:02:32,298 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-02 11:02:32,310 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-02 11:02:32,322 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-02 11:02:32,335 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-02 11:02:32,347 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-02 11:02:32,359 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-02 11:02:32,371 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-02 11:02:32,382 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-02 11:02:32,394 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-02 11:02:32,404 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-02 11:02:32,412 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-02 11:02:32,421 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-02 11:02:32,430 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-02 11:02:32,439 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-02 11:02:32,452 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-02 11:02:32,461 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-02 11:02:32,470 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-02 11:02:32,479 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-02 11:02:32,496 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-02 11:02:32,505 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-02 11:02:32,514 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-02 11:02:32,522 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-02 11:02:32,531 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-02 11:02:32,540 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-02 11:02:32,543 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-02 11:02:32,544 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-02 11:02:32,544 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-02 11:02:32,544 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-02 11:02:32,544 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-02 11:02:32,545 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-02 11:02:32,545 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-02 11:02:32,545 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-02 11:02:32,546 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-02 11:02:32,546 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-02 11:02:32,546 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-02 11:02:32,546 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-02 11:02:32,546 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-02 11:02:32,547 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-02 11:02:32,547 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-02 11:02:32,547 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-02 11:02:32,547 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-02 11:02:32,548 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-02 11:02:32,548 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-02 11:02:32,548 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-02 11:02:32,548 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-02 11:02:32,549 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-02 11:02:32,549 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-02 11:02:32,549 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-02 11:02:32,549 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-02 11:02:32,549 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-02 11:02:32,550 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-02 11:02:32,550 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-02 11:02:32,550 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-02 11:02:32,551 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-02 11:02:32,551 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-02 11:02:32,551 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-02 11:02:32,551 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-02 11:02:32,554 [salt.utils.extmods][INFO    ][22551] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-02 11:02:32,557 [salt.utils.extmods][INFO    ][22551] Syncing sdb for environment 'base'
2017-12-02 11:02:32,557 [salt.utils.extmods][INFO    ][22551] Loading cache from salt://_sdb, for base)
2017-12-02 11:02:32,557 [salt.fileclient  ][INFO    ][22551] Caching directory '_sdb/' for environment 'base'
2017-12-02 11:02:32,587 [salt.utils.extmods][INFO    ][22551] Syncing grains for environment 'base'
2017-12-02 11:02:32,587 [salt.utils.extmods][INFO    ][22551] Loading cache from salt://_grains, for base)
2017-12-02 11:02:32,587 [salt.fileclient  ][INFO    ][22551] Caching directory '_grains/' for environment 'base'
2017-12-02 11:02:32,621 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-02 11:02:32,629 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-02 11:02:32,638 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-02 11:02:32,649 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-02 11:02:32,658 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-02 11:02:32,666 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-02 11:02:32,675 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-02 11:02:32,684 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-02 11:02:32,919 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-02 11:02:32,932 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-02 11:02:32,945 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-02 11:02:32,960 [salt.fileclient  ][INFO    ][22551] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-02 11:02:32,964 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-02 11:02:32,964 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-02 11:02:32,964 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-02 11:02:32,965 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-02 11:02:32,965 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-02 11:02:32,965 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-02 11:02:32,965 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-02 11:02:32,966 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-02 11:02:32,966 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-02 11:02:32,966 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-02 11:02:32,966 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-02 11:02:32,966 [salt.utils.extmods][INFO    ][22551] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-02 11:02:32,968 [salt.utils.extmods][INFO    ][22551] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-02 11:02:32,971 [salt.utils.extmods][INFO    ][22551] Syncing renderers for environment 'base'
2017-12-02 11:02:32,971 [salt.utils.extmods][INFO    ][22551] Loading cache from salt://_renderers, for base)
2017-12-02 11:02:32,971 [salt.fileclient  ][INFO    ][22551] Caching directory '_renderers/' for environment 'base'
2017-12-02 11:02:33,012 [salt.utils.extmods][INFO    ][22551] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-02 11:02:33,015 [salt.utils.extmods][INFO    ][22551] Syncing returners for environment 'base'
2017-12-02 11:02:33,015 [salt.utils.extmods][INFO    ][22551] Loading cache from salt://_returners, for base)
2017-12-02 11:02:33,015 [salt.fileclient  ][INFO    ][22551] Caching directory '_returners/' for environment 'base'
2017-12-02 11:02:33,053 [salt.utils.extmods][INFO    ][22551] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-02 11:02:33,056 [salt.utils.extmods][INFO    ][22551] Syncing output for environment 'base'
2017-12-02 11:02:33,056 [salt.utils.extmods][INFO    ][22551] Loading cache from salt://_output, for base)
2017-12-02 11:02:33,056 [salt.fileclient  ][INFO    ][22551] Caching directory '_output/' for environment 'base'
2017-12-02 11:02:33,091 [salt.utils.extmods][INFO    ][22551] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-02 11:02:33,094 [salt.utils.extmods][INFO    ][22551] Syncing utils for environment 'base'
2017-12-02 11:02:33,094 [salt.utils.extmods][INFO    ][22551] Loading cache from salt://_utils, for base)
2017-12-02 11:02:33,094 [salt.fileclient  ][INFO    ][22551] Caching directory '_utils/' for environment 'base'
2017-12-02 11:02:33,131 [salt.utils.extmods][INFO    ][22551] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-02 11:02:33,133 [salt.utils.extmods][INFO    ][22551] Syncing log_handlers for environment 'base'
2017-12-02 11:02:33,134 [salt.utils.extmods][INFO    ][22551] Loading cache from salt://_log_handlers, for base)
2017-12-02 11:02:33,134 [salt.fileclient  ][INFO    ][22551] Caching directory '_log_handlers/' for environment 'base'
2017-12-02 11:02:33,170 [salt.utils.extmods][INFO    ][22551] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-02 11:02:33,173 [salt.utils.extmods][INFO    ][22551] Syncing proxy for environment 'base'
2017-12-02 11:02:33,173 [salt.utils.extmods][INFO    ][22551] Loading cache from salt://_proxy, for base)
2017-12-02 11:02:33,173 [salt.fileclient  ][INFO    ][22551] Caching directory '_proxy/' for environment 'base'
2017-12-02 11:02:33,206 [salt.utils.extmods][INFO    ][22551] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-02 11:02:33,209 [salt.utils.extmods][INFO    ][22551] Syncing engines for environment 'base'
2017-12-02 11:02:33,209 [salt.utils.extmods][INFO    ][22551] Loading cache from salt://_engines, for base)
2017-12-02 11:02:33,209 [salt.fileclient  ][INFO    ][22551] Caching directory '_engines/' for environment 'base'
2017-12-02 11:02:33,240 [salt.minion      ][INFO    ][22551] Returning information for job: 20171202110229129092
2017-12-02 11:02:34,876 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command state.sls with jid 20171202110234546258
2017-12-02 11:02:34,885 [salt.minion      ][INFO    ][22646] Starting a new job with PID 22646
2017-12-02 11:02:35,489 [salt.state       ][INFO    ][22646] Loading fresh modules for state activity
2017-12-02 11:02:35,589 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-02 11:02:35,611 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-02 11:02:35,641 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 11:02:35,728 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-02 11:02:35,744 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-02 11:02:35,777 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 11:02:35,849 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-02 11:02:35,871 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-02 11:02:35,928 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-02 11:02:35,952 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-02 11:02:35,968 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-02 11:02:35,986 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-02 11:02:35,995 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-02 11:02:36,018 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-02 11:02:36,037 [py.warnings      ][WARNING ][22646] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-12-02 11:02:36,037 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'salt-minion --version' in directory '/root'
2017-12-02 11:02:36,291 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-02 11:02:36,315 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-02 11:02:36,327 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-02 11:02:36,340 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-02 11:02:36,384 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-02 11:02:36,398 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-02 11:02:36,422 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-02 11:02:36,435 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-02 11:02:36,454 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-02 11:02:36,495 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-02 11:02:36,563 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-02 11:02:36,583 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 11:02:36,644 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-02 11:02:36,662 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-02 11:02:36,716 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-02 11:02:36,734 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-02 11:02:36,745 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-02 11:02:36,761 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-02 11:02:36,769 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-02 11:02:36,787 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-02 11:02:36,805 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'salt-minion --version' in directory '/root'
2017-12-02 11:02:37,060 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-02 11:02:37,077 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-02 11:02:37,088 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-02 11:02:37,099 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-02 11:02:37,142 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-02 11:02:37,160 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-02 11:02:37,184 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-02 11:02:37,197 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-02 11:02:37,216 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-02 11:02:37,255 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-02 11:02:37,340 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-02 11:02:37,412 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 11:02:37,780 [salt.state       ][INFO    ][22646] Running state [salt-minion] at time 11:02:37.779477
2017-12-02 11:02:37,780 [salt.state       ][INFO    ][22646] Executing state pkg.installed for salt-minion
2017-12-02 11:02:37,780 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 11:02:38,036 [salt.state       ][INFO    ][22646] Package salt-minion is already installed
2017-12-02 11:02:38,036 [salt.state       ][INFO    ][22646] Completed state [salt-minion] at time 11:02:38.036150 duration_in_ms=256.673
2017-12-02 11:02:38,036 [salt.state       ][INFO    ][22646] Running state [salt_minion_dependency_packages] at time 11:02:38.036418
2017-12-02 11:02:38,037 [salt.state       ][INFO    ][22646] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-02 11:02:38,040 [salt.state       ][INFO    ][22646] All specified packages are already installed
2017-12-02 11:02:38,041 [salt.state       ][INFO    ][22646] Completed state [salt_minion_dependency_packages] at time 11:02:38.040564 duration_in_ms=4.146
2017-12-02 11:02:38,042 [salt.state       ][INFO    ][22646] Running state [/etc/salt/minion.d/minion.conf] at time 11:02:38.042260
2017-12-02 11:02:38,042 [salt.state       ][INFO    ][22646] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-02 11:02:38,068 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-02 11:02:38,129 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 11:02:38,186 [salt.fileclient  ][INFO    ][22646] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-02 11:02:38,233 [salt.state       ][INFO    ][22646] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-02 11:02:38,233 [salt.state       ][INFO    ][22646] Completed state [/etc/salt/minion.d/minion.conf] at time 11:02:38.233227 duration_in_ms=190.966
2017-12-02 11:02:38,234 [salt.state       ][INFO    ][22646] Running state [/etc/salt/minion.d/_virt.conf] at time 11:02:38.233617
2017-12-02 11:02:38,234 [salt.state       ][INFO    ][22646] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-02 11:02:38,235 [salt.state       ][INFO    ][22646] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-02 11:02:38,235 [salt.state       ][INFO    ][22646] Completed state [/etc/salt/minion.d/_virt.conf] at time 11:02:38.234688 duration_in_ms=1.07
2017-12-02 11:02:38,236 [salt.state       ][INFO    ][22646] Running state [salt-minion] at time 11:02:38.236328
2017-12-02 11:02:38,237 [salt.state       ][INFO    ][22646] Executing state service.running for salt-minion
2017-12-02 11:02:38,237 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-02 11:02:38,251 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-02 11:02:38,258 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-02 11:02:38,265 [salt.state       ][INFO    ][22646] The service salt-minion is already running
2017-12-02 11:02:38,265 [salt.state       ][INFO    ][22646] Completed state [salt-minion] at time 11:02:38.265058 duration_in_ms=28.73
2017-12-02 11:02:38,267 [salt.state       ][INFO    ][22646] Running state [/etc/salt/grains.d] at time 11:02:38.266683
2017-12-02 11:02:38,267 [salt.state       ][INFO    ][22646] Executing state file.directory for /etc/salt/grains.d
2017-12-02 11:02:38,268 [salt.state       ][INFO    ][22646] Directory /etc/salt/grains.d is in the correct state
2017-12-02 11:02:38,268 [salt.state       ][INFO    ][22646] Completed state [/etc/salt/grains.d] at time 11:02:38.267694 duration_in_ms=1.011
2017-12-02 11:02:38,268 [salt.state       ][INFO    ][22646] Running state [/etc/salt/grains] at time 11:02:38.268264
2017-12-02 11:02:38,269 [salt.state       ][INFO    ][22646] Executing state file.managed for /etc/salt/grains
2017-12-02 11:02:38,269 [salt.state       ][INFO    ][22646] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-02 11:02:38,269 [salt.state       ][INFO    ][22646] Completed state [/etc/salt/grains] at time 11:02:38.269013 duration_in_ms=0.749
2017-12-02 11:02:38,269 [salt.state       ][INFO    ][22646] Running state [/etc/salt/grains.d/placeholder] at time 11:02:38.269394
2017-12-02 11:02:38,270 [salt.state       ][INFO    ][22646] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-02 11:02:38,270 [salt.state       ][INFO    ][22646] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-02 11:02:38,270 [salt.state       ][INFO    ][22646] Completed state [/etc/salt/grains.d/placeholder] at time 11:02:38.270111 duration_in_ms=0.717
2017-12-02 11:02:38,271 [salt.state       ][INFO    ][22646] Running state [/etc/salt/grains.d/sphinx] at time 11:02:38.270490
2017-12-02 11:02:38,271 [salt.state       ][INFO    ][22646] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-02 11:02:38,272 [salt.state       ][INFO    ][22646] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.143
               - 192.168.11.251
-              - 192.168.122.1
         system:
           name: System
           param:

2017-12-02 11:02:38,272 [salt.state       ][INFO    ][22646] Completed state [/etc/salt/grains.d/sphinx] at time 11:02:38.272241 duration_in_ms=1.75
2017-12-02 11:02:38,273 [salt.state       ][INFO    ][22646] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:02:38.272995
2017-12-02 11:02:38,273 [salt.state       ][INFO    ][22646] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-02 11:02:38,273 [salt.state       ][INFO    ][22646] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-02 11:02:38,274 [salt.state       ][INFO    ][22646] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:02:38.273539 duration_in_ms=0.544
2017-12-02 11:02:38,274 [salt.state       ][INFO    ][22646] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:02:38.273692
2017-12-02 11:02:38,274 [salt.state       ][INFO    ][22646] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-02 11:02:38,275 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-12-02 11:02:38,350 [salt.state       ][INFO    ][22646] {'pid': 22697, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-02 11:02:38,351 [salt.state       ][INFO    ][22646] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:02:38.350661 duration_in_ms=76.967
2017-12-02 11:02:38,351 [salt.state       ][INFO    ][22646] Running state [/etc/salt/grains.d/dns_records] at time 11:02:38.351193
2017-12-02 11:02:38,352 [salt.state       ][INFO    ][22646] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-02 11:02:38,353 [salt.state       ][INFO    ][22646] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-02 11:02:38,353 [salt.state       ][INFO    ][22646] Completed state [/etc/salt/grains.d/dns_records] at time 11:02:38.352685 duration_in_ms=1.492
2017-12-02 11:02:38,354 [salt.state       ][INFO    ][22646] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 11:02:38.353552
2017-12-02 11:02:38,354 [salt.state       ][INFO    ][22646] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-02 11:02:38,354 [salt.state       ][INFO    ][22646] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-02 11:02:38,354 [salt.state       ][INFO    ][22646] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 11:02:38.354204 duration_in_ms=0.651
2017-12-02 11:02:38,355 [salt.state       ][INFO    ][22646] Running state [/etc/salt/grains.d/salt] at time 11:02:38.354595
2017-12-02 11:02:38,355 [salt.state       ][INFO    ][22646] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-02 11:02:38,356 [salt.state       ][INFO    ][22646] File /etc/salt/grains.d/salt is in the correct state
2017-12-02 11:02:38,356 [salt.state       ][INFO    ][22646] Completed state [/etc/salt/grains.d/salt] at time 11:02:38.355654 duration_in_ms=1.058
2017-12-02 11:02:38,356 [salt.state       ][INFO    ][22646] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 11:02:38.356401
2017-12-02 11:02:38,357 [salt.state       ][INFO    ][22646] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-02 11:02:38,357 [salt.state       ][INFO    ][22646] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-02 11:02:38,357 [salt.state       ][INFO    ][22646] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 11:02:38.356980 duration_in_ms=0.578
2017-12-02 11:02:38,359 [salt.state       ][INFO    ][22646] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:02:38.358881
2017-12-02 11:02:38,359 [salt.state       ][INFO    ][22646] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-02 11:02:38,359 [salt.state       ][INFO    ][22646] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-02 11:02:38,360 [salt.state       ][INFO    ][22646] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:02:38.359476 duration_in_ms=0.594
2017-12-02 11:02:38,360 [salt.state       ][INFO    ][22646] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:02:38.359629
2017-12-02 11:02:38,360 [salt.state       ][INFO    ][22646] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-02 11:02:38,362 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-12-02 11:02:38,368 [salt.state       ][INFO    ][22646] {'pid': 22699, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-02 11:02:38,368 [salt.state       ][INFO    ][22646] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:02:38.368334 duration_in_ms=8.704
2017-12-02 11:02:38,369 [salt.state       ][INFO    ][22646] Running state [mine.update] at time 11:02:38.369035
2017-12-02 11:02:38,369 [salt.state       ][INFO    ][22646] Executing state module.wait for mine.update
2017-12-02 11:02:38,369 [salt.state       ][INFO    ][22646] No changes made for mine.update
2017-12-02 11:02:38,370 [salt.state       ][INFO    ][22646] Completed state [mine.update] at time 11:02:38.369580 duration_in_ms=0.545
2017-12-02 11:02:38,370 [salt.state       ][INFO    ][22646] Running state [mine.update] at time 11:02:38.369727
2017-12-02 11:02:38,370 [salt.state       ][INFO    ][22646] Executing state module.mod_watch for mine.update
2017-12-02 11:02:38,886 [salt.state       ][INFO    ][22646] {'ret': True}
2017-12-02 11:02:38,887 [salt.state       ][INFO    ][22646] Completed state [mine.update] at time 11:02:38.886682 duration_in_ms=516.955
2017-12-02 11:02:38,887 [salt.state       ][INFO    ][22646] Running state [ca-certificates] at time 11:02:38.886935
2017-12-02 11:02:38,887 [salt.state       ][INFO    ][22646] Executing state pkg.installed for ca-certificates
2017-12-02 11:02:38,891 [salt.state       ][INFO    ][22646] Package ca-certificates is already installed
2017-12-02 11:02:38,891 [salt.state       ][INFO    ][22646] Completed state [ca-certificates] at time 11:02:38.891292 duration_in_ms=4.357
2017-12-02 11:02:38,892 [salt.state       ][INFO    ][22646] Running state [update-ca-certificates] at time 11:02:38.891924
2017-12-02 11:02:38,892 [salt.state       ][INFO    ][22646] Executing state cmd.wait for update-ca-certificates
2017-12-02 11:02:38,892 [salt.state       ][INFO    ][22646] No changes made for update-ca-certificates
2017-12-02 11:02:38,893 [salt.state       ][INFO    ][22646] Completed state [update-ca-certificates] at time 11:02:38.892494 duration_in_ms=0.57
2017-12-02 11:02:38,893 [salt.state       ][INFO    ][22646] Running state [libvirt-dev] at time 11:02:38.892666
2017-12-02 11:02:38,893 [salt.state       ][INFO    ][22646] Executing state pkg.installed for libvirt-dev
2017-12-02 11:02:38,897 [salt.state       ][INFO    ][22646] Package libvirt-dev is already installed
2017-12-02 11:02:38,897 [salt.state       ][INFO    ][22646] Completed state [libvirt-dev] at time 11:02:38.896655 duration_in_ms=3.989
2017-12-02 11:02:38,897 [salt.state       ][INFO    ][22646] Running state [pkg-config] at time 11:02:38.896848
2017-12-02 11:02:38,897 [salt.state       ][INFO    ][22646] Executing state pkg.installed for pkg-config
2017-12-02 11:02:38,901 [salt.state       ][INFO    ][22646] Package pkg-config is already installed
2017-12-02 11:02:38,901 [salt.state       ][INFO    ][22646] Completed state [pkg-config] at time 11:02:38.900882 duration_in_ms=4.034
2017-12-02 11:02:38,901 [salt.state       ][INFO    ][22646] Running state [virtng.init] at time 11:02:38.901065
2017-12-02 11:02:38,901 [salt.state       ][INFO    ][22646] Executing state module.run for virtng.init
2017-12-02 11:02:38,997 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command ['git', '--version'] in directory '/root'
2017-12-02 11:02:39,049 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:02:39,066 [salt.state       ][INFO    ][22646] unless execution succeeded
2017-12-02 11:02:39,066 [salt.state       ][INFO    ][22646] Completed state [virtng.init] at time 11:02:39.065972 duration_in_ms=164.906
2017-12-02 11:02:39,066 [salt.state       ][INFO    ][22646] Running state [virt.set_autostart] at time 11:02:39.066298
2017-12-02 11:02:39,067 [salt.state       ][INFO    ][22646] Executing state module.run for virt.set_autostart
2017-12-02 11:02:39,069 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:02:39,086 [salt.state       ][INFO    ][22646] unless execution succeeded
2017-12-02 11:02:39,086 [salt.state       ][INFO    ][22646] Completed state [virt.set_autostart] at time 11:02:39.086036 duration_in_ms=19.737
2017-12-02 11:02:39,086 [salt.state       ][INFO    ][22646] Running state [virtng.init] at time 11:02:39.086312
2017-12-02 11:02:39,087 [salt.state       ][INFO    ][22646] Executing state module.run for virtng.init
2017-12-02 11:02:39,089 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:02:39,103 [salt.state       ][INFO    ][22646] unless execution succeeded
2017-12-02 11:02:39,104 [salt.state       ][INFO    ][22646] Completed state [virtng.init] at time 11:02:39.103629 duration_in_ms=17.315
2017-12-02 11:02:39,104 [salt.state       ][INFO    ][22646] Running state [virt.set_autostart] at time 11:02:39.103872
2017-12-02 11:02:39,104 [salt.state       ][INFO    ][22646] Executing state module.run for virt.set_autostart
2017-12-02 11:02:39,107 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:02:39,121 [salt.state       ][INFO    ][22646] unless execution succeeded
2017-12-02 11:02:39,122 [salt.state       ][INFO    ][22646] Completed state [virt.set_autostart] at time 11:02:39.121609 duration_in_ms=17.729
2017-12-02 11:02:39,122 [salt.state       ][INFO    ][22646] Running state [virtng.init] at time 11:02:39.121845
2017-12-02 11:02:39,122 [salt.state       ][INFO    ][22646] Executing state module.run for virtng.init
2017-12-02 11:02:39,125 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:02:39,139 [salt.state       ][INFO    ][22646] unless execution succeeded
2017-12-02 11:02:39,139 [salt.state       ][INFO    ][22646] Completed state [virtng.init] at time 11:02:39.138789 duration_in_ms=16.944
2017-12-02 11:02:39,139 [salt.state       ][INFO    ][22646] Running state [virt.set_autostart] at time 11:02:39.139038
2017-12-02 11:02:39,139 [salt.state       ][INFO    ][22646] Executing state module.run for virt.set_autostart
2017-12-02 11:02:39,142 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:02:39,156 [salt.state       ][INFO    ][22646] unless execution succeeded
2017-12-02 11:02:39,157 [salt.state       ][INFO    ][22646] Completed state [virt.set_autostart] at time 11:02:39.156599 duration_in_ms=17.561
2017-12-02 11:02:39,157 [salt.state       ][INFO    ][22646] Running state [virtng.init] at time 11:02:39.156838
2017-12-02 11:02:39,157 [salt.state       ][INFO    ][22646] Executing state module.run for virtng.init
2017-12-02 11:02:39,160 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'virsh list --all --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:02:39,174 [salt.state       ][INFO    ][22646] unless execution succeeded
2017-12-02 11:02:39,175 [salt.state       ][INFO    ][22646] Completed state [virtng.init] at time 11:02:39.174605 duration_in_ms=17.767
2017-12-02 11:02:39,175 [salt.state       ][INFO    ][22646] Running state [virt.set_autostart] at time 11:02:39.174829
2017-12-02 11:02:39,175 [salt.state       ][INFO    ][22646] Executing state module.run for virt.set_autostart
2017-12-02 11:02:39,177 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'virsh list --autostart --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:02:39,191 [salt.state       ][INFO    ][22646] unless execution succeeded
2017-12-02 11:02:39,191 [salt.state       ][INFO    ][22646] Completed state [virt.set_autostart] at time 11:02:39.190923 duration_in_ms=16.093
2017-12-02 11:02:39,191 [salt.state       ][INFO    ][22646] Running state [virtng.init] at time 11:02:39.191139
2017-12-02 11:02:39,191 [salt.state       ][INFO    ][22646] Executing state module.run for virtng.init
2017-12-02 11:02:39,194 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:02:39,209 [salt.state       ][INFO    ][22646] unless execution succeeded
2017-12-02 11:02:39,209 [salt.state       ][INFO    ][22646] Completed state [virtng.init] at time 11:02:39.209115 duration_in_ms=17.976
2017-12-02 11:02:39,209 [salt.state       ][INFO    ][22646] Running state [virt.set_autostart] at time 11:02:39.209380
2017-12-02 11:02:39,210 [salt.state       ][INFO    ][22646] Executing state module.run for virt.set_autostart
2017-12-02 11:02:39,212 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:02:39,227 [salt.state       ][INFO    ][22646] unless execution succeeded
2017-12-02 11:02:39,227 [salt.state       ][INFO    ][22646] Completed state [virt.set_autostart] at time 11:02:39.226789 duration_in_ms=17.409
2017-12-02 11:02:39,227 [salt.state       ][INFO    ][22646] Running state [virtng.init] at time 11:02:39.227024
2017-12-02 11:02:39,227 [salt.state       ][INFO    ][22646] Executing state module.run for virtng.init
2017-12-02 11:02:39,230 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:02:39,245 [salt.state       ][INFO    ][22646] unless execution succeeded
2017-12-02 11:02:39,245 [salt.state       ][INFO    ][22646] Completed state [virtng.init] at time 11:02:39.244803 duration_in_ms=17.778
2017-12-02 11:02:39,245 [salt.state       ][INFO    ][22646] Running state [virt.set_autostart] at time 11:02:39.245041
2017-12-02 11:02:39,245 [salt.state       ][INFO    ][22646] Executing state module.run for virt.set_autostart
2017-12-02 11:02:39,248 [salt.loaded.int.module.cmdmod][INFO    ][22646] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:02:39,262 [salt.state       ][INFO    ][22646] unless execution succeeded
2017-12-02 11:02:39,262 [salt.state       ][INFO    ][22646] Completed state [virt.set_autostart] at time 11:02:39.262140 duration_in_ms=17.099
2017-12-02 11:02:39,265 [salt.minion      ][INFO    ][22646] Returning information for job: 20171202110234546258
2017-12-02 11:03:05,566 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command state.sls with jid 20171202110305539189
2017-12-02 11:03:05,577 [salt.minion      ][INFO    ][22767] Starting a new job with PID 22767
2017-12-02 11:03:07,936 [salt.state       ][INFO    ][22767] Loading fresh modules for state activity
2017-12-02 11:03:07,970 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-02 11:03:08,020 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-02 11:03:08,050 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 11:03:08,140 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-02 11:03:08,156 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-02 11:03:08,183 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 11:03:08,255 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-02 11:03:08,276 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-02 11:03:08,333 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-02 11:03:08,356 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-02 11:03:08,372 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-02 11:03:08,390 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-02 11:03:08,399 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-02 11:03:08,421 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-02 11:03:08,439 [py.warnings      ][WARNING ][22767] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-12-02 11:03:08,440 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'salt-minion --version' in directory '/root'
2017-12-02 11:03:08,703 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-02 11:03:08,723 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-02 11:03:08,735 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-02 11:03:08,747 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-02 11:03:08,790 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-02 11:03:08,806 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-02 11:03:08,830 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-02 11:03:08,847 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-02 11:03:08,868 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-02 11:03:08,908 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-02 11:03:08,980 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-02 11:03:09,006 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 11:03:09,074 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-02 11:03:09,098 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-02 11:03:09,155 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-02 11:03:09,176 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-02 11:03:09,191 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-02 11:03:09,207 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-02 11:03:09,216 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-02 11:03:09,237 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-02 11:03:09,255 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'salt-minion --version' in directory '/root'
2017-12-02 11:03:09,518 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-02 11:03:09,539 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-02 11:03:09,551 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-02 11:03:09,566 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-02 11:03:09,609 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-02 11:03:09,624 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-02 11:03:09,651 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-02 11:03:09,667 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-02 11:03:09,688 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-02 11:03:09,732 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-02 11:03:09,818 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-02 11:03:09,895 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 11:03:10,225 [salt.state       ][INFO    ][22767] Running state [salt-minion] at time 11:03:10.225226
2017-12-02 11:03:10,226 [salt.state       ][INFO    ][22767] Executing state pkg.installed for salt-minion
2017-12-02 11:03:10,226 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 11:03:10,480 [salt.state       ][INFO    ][22767] Package salt-minion is already installed
2017-12-02 11:03:10,480 [salt.state       ][INFO    ][22767] Completed state [salt-minion] at time 11:03:10.480250 duration_in_ms=255.023
2017-12-02 11:03:10,481 [salt.state       ][INFO    ][22767] Running state [salt_minion_dependency_packages] at time 11:03:10.480522
2017-12-02 11:03:10,481 [salt.state       ][INFO    ][22767] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-02 11:03:10,484 [salt.state       ][INFO    ][22767] All specified packages are already installed
2017-12-02 11:03:10,485 [salt.state       ][INFO    ][22767] Completed state [salt_minion_dependency_packages] at time 11:03:10.484646 duration_in_ms=4.124
2017-12-02 11:03:10,486 [salt.state       ][INFO    ][22767] Running state [/etc/salt/minion.d/minion.conf] at time 11:03:10.486330
2017-12-02 11:03:10,487 [salt.state       ][INFO    ][22767] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-02 11:03:10,511 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-02 11:03:10,572 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-02 11:03:10,628 [salt.fileclient  ][INFO    ][22767] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-02 11:03:10,675 [salt.state       ][INFO    ][22767] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-02 11:03:10,675 [salt.state       ][INFO    ][22767] Completed state [/etc/salt/minion.d/minion.conf] at time 11:03:10.674666 duration_in_ms=188.336
2017-12-02 11:03:10,675 [salt.state       ][INFO    ][22767] Running state [/etc/salt/minion.d/_virt.conf] at time 11:03:10.675059
2017-12-02 11:03:10,675 [salt.state       ][INFO    ][22767] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-02 11:03:10,676 [salt.state       ][INFO    ][22767] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-02 11:03:10,676 [salt.state       ][INFO    ][22767] Completed state [/etc/salt/minion.d/_virt.conf] at time 11:03:10.676090 duration_in_ms=1.03
2017-12-02 11:03:10,678 [salt.state       ][INFO    ][22767] Running state [salt-minion] at time 11:03:10.677770
2017-12-02 11:03:10,678 [salt.state       ][INFO    ][22767] Executing state service.running for salt-minion
2017-12-02 11:03:10,678 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-02 11:03:10,694 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-02 11:03:10,700 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-02 11:03:10,708 [salt.state       ][INFO    ][22767] The service salt-minion is already running
2017-12-02 11:03:10,708 [salt.state       ][INFO    ][22767] Completed state [salt-minion] at time 11:03:10.707960 duration_in_ms=30.189
2017-12-02 11:03:10,710 [salt.state       ][INFO    ][22767] Running state [/etc/salt/grains.d] at time 11:03:10.709503
2017-12-02 11:03:10,710 [salt.state       ][INFO    ][22767] Executing state file.directory for /etc/salt/grains.d
2017-12-02 11:03:10,710 [salt.state       ][INFO    ][22767] Directory /etc/salt/grains.d is in the correct state
2017-12-02 11:03:10,711 [salt.state       ][INFO    ][22767] Completed state [/etc/salt/grains.d] at time 11:03:10.710554 duration_in_ms=1.05
2017-12-02 11:03:10,711 [salt.state       ][INFO    ][22767] Running state [/etc/salt/grains] at time 11:03:10.711110
2017-12-02 11:03:10,711 [salt.state       ][INFO    ][22767] Executing state file.managed for /etc/salt/grains
2017-12-02 11:03:10,712 [salt.state       ][INFO    ][22767] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-02 11:03:10,712 [salt.state       ][INFO    ][22767] Completed state [/etc/salt/grains] at time 11:03:10.711842 duration_in_ms=0.732
2017-12-02 11:03:10,712 [salt.state       ][INFO    ][22767] Running state [/etc/salt/grains.d/placeholder] at time 11:03:10.712218
2017-12-02 11:03:10,712 [salt.state       ][INFO    ][22767] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-02 11:03:10,713 [salt.state       ][INFO    ][22767] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-02 11:03:10,713 [salt.state       ][INFO    ][22767] Completed state [/etc/salt/grains.d/placeholder] at time 11:03:10.712941 duration_in_ms=0.723
2017-12-02 11:03:10,713 [salt.state       ][INFO    ][22767] Running state [/etc/salt/grains.d/sphinx] at time 11:03:10.713320
2017-12-02 11:03:10,714 [salt.state       ][INFO    ][22767] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-02 11:03:10,714 [salt.state       ][INFO    ][22767] File /etc/salt/grains.d/sphinx is in the correct state
2017-12-02 11:03:10,714 [salt.state       ][INFO    ][22767] Completed state [/etc/salt/grains.d/sphinx] at time 11:03:10.714462 duration_in_ms=1.142
2017-12-02 11:03:10,715 [salt.state       ][INFO    ][22767] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:03:10.715218
2017-12-02 11:03:10,715 [salt.state       ][INFO    ][22767] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-02 11:03:10,716 [salt.state       ][INFO    ][22767] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-02 11:03:10,716 [salt.state       ][INFO    ][22767] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:03:10.715791 duration_in_ms=0.573
2017-12-02 11:03:10,716 [salt.state       ][INFO    ][22767] Running state [/etc/salt/grains.d/dns_records] at time 11:03:10.716156
2017-12-02 11:03:10,716 [salt.state       ][INFO    ][22767] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-02 11:03:10,717 [salt.state       ][INFO    ][22767] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-02 11:03:10,717 [salt.state       ][INFO    ][22767] Completed state [/etc/salt/grains.d/dns_records] at time 11:03:10.717165 duration_in_ms=1.01
2017-12-02 11:03:10,718 [salt.state       ][INFO    ][22767] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 11:03:10.717956
2017-12-02 11:03:10,718 [salt.state       ][INFO    ][22767] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-02 11:03:10,718 [salt.state       ][INFO    ][22767] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-02 11:03:10,719 [salt.state       ][INFO    ][22767] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 11:03:10.718527 duration_in_ms=0.571
2017-12-02 11:03:10,719 [salt.state       ][INFO    ][22767] Running state [/etc/salt/grains.d/salt] at time 11:03:10.718898
2017-12-02 11:03:10,719 [salt.state       ][INFO    ][22767] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-02 11:03:10,720 [salt.state       ][INFO    ][22767] File /etc/salt/grains.d/salt is in the correct state
2017-12-02 11:03:10,720 [salt.state       ][INFO    ][22767] Completed state [/etc/salt/grains.d/salt] at time 11:03:10.719875 duration_in_ms=0.976
2017-12-02 11:03:10,721 [salt.state       ][INFO    ][22767] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 11:03:10.720604
2017-12-02 11:03:10,721 [salt.state       ][INFO    ][22767] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-02 11:03:10,721 [salt.state       ][INFO    ][22767] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-02 11:03:10,721 [salt.state       ][INFO    ][22767] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 11:03:10.721175 duration_in_ms=0.572
2017-12-02 11:03:10,723 [salt.state       ][INFO    ][22767] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:03:10.722844
2017-12-02 11:03:10,723 [salt.state       ][INFO    ][22767] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-02 11:03:10,723 [salt.state       ][INFO    ][22767] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-02 11:03:10,723 [salt.state       ][INFO    ][22767] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:03:10.723442 duration_in_ms=0.598
2017-12-02 11:03:10,724 [salt.state       ][INFO    ][22767] Running state [mine.update] at time 11:03:10.723976
2017-12-02 11:03:10,724 [salt.state       ][INFO    ][22767] Executing state module.wait for mine.update
2017-12-02 11:03:10,724 [salt.state       ][INFO    ][22767] No changes made for mine.update
2017-12-02 11:03:10,725 [salt.state       ][INFO    ][22767] Completed state [mine.update] at time 11:03:10.724504 duration_in_ms=0.528
2017-12-02 11:03:10,725 [salt.state       ][INFO    ][22767] Running state [ca-certificates] at time 11:03:10.724673
2017-12-02 11:03:10,725 [salt.state       ][INFO    ][22767] Executing state pkg.installed for ca-certificates
2017-12-02 11:03:10,729 [salt.state       ][INFO    ][22767] Package ca-certificates is already installed
2017-12-02 11:03:10,729 [salt.state       ][INFO    ][22767] Completed state [ca-certificates] at time 11:03:10.729024 duration_in_ms=4.351
2017-12-02 11:03:10,730 [salt.state       ][INFO    ][22767] Running state [update-ca-certificates] at time 11:03:10.729581
2017-12-02 11:03:10,730 [salt.state       ][INFO    ][22767] Executing state cmd.wait for update-ca-certificates
2017-12-02 11:03:10,730 [salt.state       ][INFO    ][22767] No changes made for update-ca-certificates
2017-12-02 11:03:10,730 [salt.state       ][INFO    ][22767] Completed state [update-ca-certificates] at time 11:03:10.730139 duration_in_ms=0.559
2017-12-02 11:03:10,730 [salt.state       ][INFO    ][22767] Running state [libvirt-dev] at time 11:03:10.730312
2017-12-02 11:03:10,730 [salt.state       ][INFO    ][22767] Executing state pkg.installed for libvirt-dev
2017-12-02 11:03:10,734 [salt.state       ][INFO    ][22767] Package libvirt-dev is already installed
2017-12-02 11:03:10,734 [salt.state       ][INFO    ][22767] Completed state [libvirt-dev] at time 11:03:10.734407 duration_in_ms=4.095
2017-12-02 11:03:10,735 [salt.state       ][INFO    ][22767] Running state [pkg-config] at time 11:03:10.734602
2017-12-02 11:03:10,735 [salt.state       ][INFO    ][22767] Executing state pkg.installed for pkg-config
2017-12-02 11:03:10,738 [salt.state       ][INFO    ][22767] Package pkg-config is already installed
2017-12-02 11:03:10,739 [salt.state       ][INFO    ][22767] Completed state [pkg-config] at time 11:03:10.738610 duration_in_ms=4.009
2017-12-02 11:03:10,739 [salt.state       ][INFO    ][22767] Running state [virtng.init] at time 11:03:10.738803
2017-12-02 11:03:10,739 [salt.state       ][INFO    ][22767] Executing state module.run for virtng.init
2017-12-02 11:03:10,826 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command ['git', '--version'] in directory '/root'
2017-12-02 11:03:10,873 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:03:10,891 [salt.state       ][INFO    ][22767] unless execution succeeded
2017-12-02 11:03:10,891 [salt.state       ][INFO    ][22767] Completed state [virtng.init] at time 11:03:10.890991 duration_in_ms=152.188
2017-12-02 11:03:10,891 [salt.state       ][INFO    ][22767] Running state [virt.set_autostart] at time 11:03:10.891246
2017-12-02 11:03:10,891 [salt.state       ][INFO    ][22767] Executing state module.run for virt.set_autostart
2017-12-02 11:03:10,894 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:03:10,909 [salt.state       ][INFO    ][22767] unless execution succeeded
2017-12-02 11:03:10,910 [salt.state       ][INFO    ][22767] Completed state [virt.set_autostart] at time 11:03:10.909596 duration_in_ms=18.35
2017-12-02 11:03:10,910 [salt.state       ][INFO    ][22767] Running state [virtng.init] at time 11:03:10.909862
2017-12-02 11:03:10,910 [salt.state       ][INFO    ][22767] Executing state module.run for virtng.init
2017-12-02 11:03:10,913 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:03:10,928 [salt.state       ][INFO    ][22767] unless execution succeeded
2017-12-02 11:03:10,928 [salt.state       ][INFO    ][22767] Completed state [virtng.init] at time 11:03:10.927878 duration_in_ms=18.016
2017-12-02 11:03:10,928 [salt.state       ][INFO    ][22767] Running state [virt.set_autostart] at time 11:03:10.928107
2017-12-02 11:03:10,928 [salt.state       ][INFO    ][22767] Executing state module.run for virt.set_autostart
2017-12-02 11:03:10,931 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:03:10,947 [salt.state       ][INFO    ][22767] unless execution succeeded
2017-12-02 11:03:10,947 [salt.state       ][INFO    ][22767] Completed state [virt.set_autostart] at time 11:03:10.947020 duration_in_ms=18.912
2017-12-02 11:03:10,947 [salt.state       ][INFO    ][22767] Running state [virtng.init] at time 11:03:10.947289
2017-12-02 11:03:10,948 [salt.state       ][INFO    ][22767] Executing state module.run for virtng.init
2017-12-02 11:03:10,950 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:03:10,965 [salt.state       ][INFO    ][22767] unless execution succeeded
2017-12-02 11:03:10,965 [salt.state       ][INFO    ][22767] Completed state [virtng.init] at time 11:03:10.964996 duration_in_ms=17.707
2017-12-02 11:03:10,965 [salt.state       ][INFO    ][22767] Running state [virt.set_autostart] at time 11:03:10.965216
2017-12-02 11:03:10,965 [salt.state       ][INFO    ][22767] Executing state module.run for virt.set_autostart
2017-12-02 11:03:10,968 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:03:10,984 [salt.state       ][INFO    ][22767] unless execution succeeded
2017-12-02 11:03:10,984 [salt.state       ][INFO    ][22767] Completed state [virt.set_autostart] at time 11:03:10.983793 duration_in_ms=18.576
2017-12-02 11:03:10,984 [salt.state       ][INFO    ][22767] Running state [virtng.init] at time 11:03:10.984057
2017-12-02 11:03:10,984 [salt.state       ][INFO    ][22767] Executing state module.run for virtng.init
2017-12-02 11:03:10,987 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'virsh list --all --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:03:11,001 [salt.state       ][INFO    ][22767] unless execution succeeded
2017-12-02 11:03:11,002 [salt.state       ][INFO    ][22767] Completed state [virtng.init] at time 11:03:11.001643 duration_in_ms=17.586
2017-12-02 11:03:11,002 [salt.state       ][INFO    ][22767] Running state [virt.set_autostart] at time 11:03:11.001866
2017-12-02 11:03:11,002 [salt.state       ][INFO    ][22767] Executing state module.run for virt.set_autostart
2017-12-02 11:03:11,005 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'virsh list --autostart --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:03:11,020 [salt.state       ][INFO    ][22767] unless execution succeeded
2017-12-02 11:03:11,020 [salt.state       ][INFO    ][22767] Completed state [virt.set_autostart] at time 11:03:11.020409 duration_in_ms=18.543
2017-12-02 11:03:11,021 [salt.state       ][INFO    ][22767] Running state [virtng.init] at time 11:03:11.020681
2017-12-02 11:03:11,021 [salt.state       ][INFO    ][22767] Executing state module.run for virtng.init
2017-12-02 11:03:11,024 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:03:11,038 [salt.state       ][INFO    ][22767] unless execution succeeded
2017-12-02 11:03:11,038 [salt.state       ][INFO    ][22767] Completed state [virtng.init] at time 11:03:11.038230 duration_in_ms=17.549
2017-12-02 11:03:11,038 [salt.state       ][INFO    ][22767] Running state [virt.set_autostart] at time 11:03:11.038468
2017-12-02 11:03:11,039 [salt.state       ][INFO    ][22767] Executing state module.run for virt.set_autostart
2017-12-02 11:03:11,041 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:03:11,057 [salt.state       ][INFO    ][22767] unless execution succeeded
2017-12-02 11:03:11,057 [salt.state       ][INFO    ][22767] Completed state [virt.set_autostart] at time 11:03:11.056893 duration_in_ms=18.424
2017-12-02 11:03:11,057 [salt.state       ][INFO    ][22767] Running state [virtng.init] at time 11:03:11.057152
2017-12-02 11:03:11,057 [salt.state       ][INFO    ][22767] Executing state module.run for virtng.init
2017-12-02 11:03:11,060 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:03:11,075 [salt.state       ][INFO    ][22767] unless execution succeeded
2017-12-02 11:03:11,075 [salt.state       ][INFO    ][22767] Completed state [virtng.init] at time 11:03:11.074705 duration_in_ms=17.553
2017-12-02 11:03:11,075 [salt.state       ][INFO    ][22767] Running state [virt.set_autostart] at time 11:03:11.074926
2017-12-02 11:03:11,075 [salt.state       ][INFO    ][22767] Executing state module.run for virt.set_autostart
2017-12-02 11:03:11,078 [salt.loaded.int.module.cmdmod][INFO    ][22767] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-02 11:03:11,093 [salt.state       ][INFO    ][22767] unless execution succeeded
2017-12-02 11:03:11,093 [salt.state       ][INFO    ][22767] Completed state [virt.set_autostart] at time 11:03:11.093058 duration_in_ms=18.132
2017-12-02 11:03:11,096 [salt.minion      ][INFO    ][22767] Returning information for job: 20171202110305539189
2017-12-02 11:03:32,688 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171202110332663111
2017-12-02 11:03:32,700 [salt.minion      ][INFO    ][22878] Starting a new job with PID 22878
2017-12-02 11:03:36,483 [salt.state       ][INFO    ][22878] Loading fresh modules for state activity
2017-12-02 11:03:37,984 [salt.state       ][ERROR   ][22878] No contents found in top file
2017-12-02 11:03:37,985 [salt.utils.extmods][INFO    ][22878] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-02 11:03:37,988 [salt.utils.extmods][INFO    ][22878] Syncing beacons for environment 'base'
2017-12-02 11:03:37,988 [salt.utils.extmods][INFO    ][22878] Loading cache from salt://_beacons, for base)
2017-12-02 11:03:37,989 [salt.fileclient  ][INFO    ][22878] Caching directory '_beacons/' for environment 'base'
2017-12-02 11:03:38,035 [salt.utils.extmods][INFO    ][22878] Syncing modules for environment 'base'
2017-12-02 11:03:38,036 [salt.utils.extmods][INFO    ][22878] Loading cache from salt://_modules, for base)
2017-12-02 11:03:38,036 [salt.fileclient  ][INFO    ][22878] Caching directory '_modules/' for environment 'base'
2017-12-02 11:03:38,140 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-02 11:03:38,165 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-02 11:03:38,183 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-02 11:03:38,206 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-02 11:03:38,231 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-02 11:03:38,247 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-02 11:03:38,267 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-02 11:03:38,291 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-02 11:03:38,312 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-02 11:03:38,339 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-02 11:03:38,358 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-02 11:03:38,373 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-02 11:03:38,387 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-02 11:03:38,423 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-02 11:03:38,441 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-02 11:03:38,459 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-02 11:03:38,502 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-02 11:03:38,518 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-02 11:03:38,536 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-02 11:03:38,561 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-02 11:03:38,599 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-02 11:03:38,610 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-02 11:03:38,663 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-02 11:03:38,676 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-02 11:03:38,696 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-02 11:03:38,714 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-02 11:03:38,729 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-02 11:03:38,741 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-02 11:03:38,762 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-02 11:03:38,783 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-02 11:03:38,795 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-02 11:03:38,806 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-02 11:03:38,824 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-02 11:03:38,842 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-02 11:03:38,847 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-02 11:03:38,847 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-02 11:03:38,847 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-02 11:03:38,847 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-02 11:03:38,848 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-02 11:03:38,848 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-02 11:03:38,848 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-02 11:03:38,849 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-02 11:03:38,849 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-02 11:03:38,849 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-02 11:03:38,849 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-02 11:03:38,850 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-02 11:03:38,850 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-02 11:03:38,850 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-02 11:03:38,851 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-02 11:03:38,851 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-02 11:03:38,851 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-02 11:03:38,851 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-02 11:03:38,852 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-02 11:03:38,852 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-02 11:03:38,852 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-02 11:03:38,852 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-02 11:03:38,853 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-02 11:03:38,853 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-02 11:03:38,853 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-02 11:03:38,854 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-02 11:03:38,854 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-02 11:03:38,854 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-02 11:03:38,855 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-02 11:03:38,855 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-02 11:03:38,855 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-02 11:03:38,855 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-02 11:03:38,856 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-02 11:03:38,856 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-12-02 11:03:38,856 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-02 11:03:38,856 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-02 11:03:38,863 [salt.utils.extmods][INFO    ][22878] Syncing states for environment 'base'
2017-12-02 11:03:38,863 [salt.utils.extmods][INFO    ][22878] Loading cache from salt://_states, for base)
2017-12-02 11:03:38,863 [salt.fileclient  ][INFO    ][22878] Caching directory '_states/' for environment 'base'
2017-12-02 11:03:38,965 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-02 11:03:38,981 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-02 11:03:38,998 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-02 11:03:39,019 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-02 11:03:39,035 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-02 11:03:39,053 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-02 11:03:39,067 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-02 11:03:39,080 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-02 11:03:39,095 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-02 11:03:39,107 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-02 11:03:39,129 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-02 11:03:39,163 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-02 11:03:39,181 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-02 11:03:39,195 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-02 11:03:39,218 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-02 11:03:39,231 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-02 11:03:39,246 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-02 11:03:39,259 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-02 11:03:39,280 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-02 11:03:39,307 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-02 11:03:39,322 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-02 11:03:39,335 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-02 11:03:39,358 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-02 11:03:39,387 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-02 11:03:39,406 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-02 11:03:39,448 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-02 11:03:39,474 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-02 11:03:39,495 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-02 11:03:39,514 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-02 11:03:39,537 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-02 11:03:39,572 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-02 11:03:39,585 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-02 11:03:39,589 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-02 11:03:39,590 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-02 11:03:39,590 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-02 11:03:39,590 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-02 11:03:39,590 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-02 11:03:39,591 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-02 11:03:39,591 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-02 11:03:39,591 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-02 11:03:39,592 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-02 11:03:39,592 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-02 11:03:39,592 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-02 11:03:39,592 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-02 11:03:39,593 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-02 11:03:39,593 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-02 11:03:39,593 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-02 11:03:39,593 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-02 11:03:39,594 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-02 11:03:39,594 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-02 11:03:39,594 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-02 11:03:39,594 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-02 11:03:39,595 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-02 11:03:39,595 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-02 11:03:39,595 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-02 11:03:39,595 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-02 11:03:39,596 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-02 11:03:39,596 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-02 11:03:39,596 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-02 11:03:39,596 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-02 11:03:39,597 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-02 11:03:39,597 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-02 11:03:39,597 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-02 11:03:39,597 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-02 11:03:39,598 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-02 11:03:39,601 [salt.utils.extmods][INFO    ][22878] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-02 11:03:39,604 [salt.utils.extmods][INFO    ][22878] Syncing sdb for environment 'base'
2017-12-02 11:03:39,604 [salt.utils.extmods][INFO    ][22878] Loading cache from salt://_sdb, for base)
2017-12-02 11:03:39,604 [salt.fileclient  ][INFO    ][22878] Caching directory '_sdb/' for environment 'base'
2017-12-02 11:03:39,653 [salt.utils.extmods][INFO    ][22878] Syncing grains for environment 'base'
2017-12-02 11:03:39,653 [salt.utils.extmods][INFO    ][22878] Loading cache from salt://_grains, for base)
2017-12-02 11:03:39,653 [salt.fileclient  ][INFO    ][22878] Caching directory '_grains/' for environment 'base'
2017-12-02 11:03:39,740 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-02 11:03:39,752 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-02 11:03:39,773 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-02 11:03:39,787 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-02 11:03:39,826 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-02 11:03:39,860 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-02 11:03:39,875 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-02 11:03:39,900 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-02 11:03:39,924 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-02 11:03:39,960 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-02 11:03:39,979 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-02 11:03:40,060 [salt.fileclient  ][INFO    ][22878] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-02 11:03:40,065 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-02 11:03:40,065 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-02 11:03:40,065 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-02 11:03:40,066 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-02 11:03:40,066 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-02 11:03:40,066 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-02 11:03:40,066 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-02 11:03:40,067 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-02 11:03:40,067 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-02 11:03:40,067 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-02 11:03:40,067 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-02 11:03:40,068 [salt.utils.extmods][INFO    ][22878] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-02 11:03:40,069 [salt.utils.extmods][INFO    ][22878] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-02 11:03:40,072 [salt.utils.extmods][INFO    ][22878] Syncing renderers for environment 'base'
2017-12-02 11:03:40,072 [salt.utils.extmods][INFO    ][22878] Loading cache from salt://_renderers, for base)
2017-12-02 11:03:40,073 [salt.fileclient  ][INFO    ][22878] Caching directory '_renderers/' for environment 'base'
2017-12-02 11:03:40,141 [salt.utils.extmods][INFO    ][22878] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-02 11:03:40,143 [salt.utils.extmods][INFO    ][22878] Syncing returners for environment 'base'
2017-12-02 11:03:40,143 [salt.utils.extmods][INFO    ][22878] Loading cache from salt://_returners, for base)
2017-12-02 11:03:40,144 [salt.fileclient  ][INFO    ][22878] Caching directory '_returners/' for environment 'base'
2017-12-02 11:03:40,173 [salt.utils.extmods][INFO    ][22878] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-02 11:03:40,176 [salt.utils.extmods][INFO    ][22878] Syncing output for environment 'base'
2017-12-02 11:03:40,176 [salt.utils.extmods][INFO    ][22878] Loading cache from salt://_output, for base)
2017-12-02 11:03:40,176 [salt.fileclient  ][INFO    ][22878] Caching directory '_output/' for environment 'base'
2017-12-02 11:03:40,287 [salt.utils.extmods][INFO    ][22878] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-02 11:03:40,290 [salt.utils.extmods][INFO    ][22878] Syncing utils for environment 'base'
2017-12-02 11:03:40,290 [salt.utils.extmods][INFO    ][22878] Loading cache from salt://_utils, for base)
2017-12-02 11:03:40,290 [salt.fileclient  ][INFO    ][22878] Caching directory '_utils/' for environment 'base'
2017-12-02 11:03:40,326 [salt.utils.extmods][INFO    ][22878] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-02 11:03:40,330 [salt.utils.extmods][INFO    ][22878] Syncing log_handlers for environment 'base'
2017-12-02 11:03:40,330 [salt.utils.extmods][INFO    ][22878] Loading cache from salt://_log_handlers, for base)
2017-12-02 11:03:40,330 [salt.fileclient  ][INFO    ][22878] Caching directory '_log_handlers/' for environment 'base'
2017-12-02 11:03:40,361 [salt.utils.extmods][INFO    ][22878] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-02 11:03:40,364 [salt.utils.extmods][INFO    ][22878] Syncing proxy for environment 'base'
2017-12-02 11:03:40,364 [salt.utils.extmods][INFO    ][22878] Loading cache from salt://_proxy, for base)
2017-12-02 11:03:40,364 [salt.fileclient  ][INFO    ][22878] Caching directory '_proxy/' for environment 'base'
2017-12-02 11:03:40,400 [salt.utils.extmods][INFO    ][22878] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-02 11:03:40,403 [salt.utils.extmods][INFO    ][22878] Syncing engines for environment 'base'
2017-12-02 11:03:40,403 [salt.utils.extmods][INFO    ][22878] Loading cache from salt://_engines, for base)
2017-12-02 11:03:40,403 [salt.fileclient  ][INFO    ][22878] Caching directory '_engines/' for environment 'base'
2017-12-02 11:03:40,452 [salt.minion      ][INFO    ][22878] Returning information for job: 20171202110332663111
2017-12-02 11:21:44,970 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command test.ping with jid 20171202112144955810
2017-12-02 11:21:44,984 [salt.minion      ][INFO    ][23237] Starting a new job with PID 23237
2017-12-02 11:21:45,028 [salt.minion      ][INFO    ][23237] Returning information for job: 20171202112144955810
2017-12-02 11:22:01,513 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command state.sls with jid 20171202112201500318
2017-12-02 11:22:01,523 [salt.minion      ][INFO    ][23254] Starting a new job with PID 23254
2017-12-02 11:22:02,111 [salt.state       ][INFO    ][23254] Loading fresh modules for state activity
2017-12-02 11:22:02,137 [salt.fileclient  ][INFO    ][23254] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-02 11:22:02,154 [salt.fileclient  ][INFO    ][23254] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-02 11:22:02,187 [salt.fileclient  ][INFO    ][23254] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-02 11:22:02,518 [salt.state       ][INFO    ][23254] Running state [lsof] at time 11:22:02.517751
2017-12-02 11:22:02,518 [salt.state       ][INFO    ][23254] Executing state pkg.installed for lsof
2017-12-02 11:22:02,519 [salt.loaded.int.module.cmdmod][INFO    ][23254] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 11:22:02,768 [salt.state       ][INFO    ][23254] Package lsof is already installed
2017-12-02 11:22:02,768 [salt.state       ][INFO    ][23254] Completed state [lsof] at time 11:22:02.768368 duration_in_ms=250.617
2017-12-02 11:22:02,769 [salt.state       ][INFO    ][23254] Running state [keepalived] at time 11:22:02.768630
2017-12-02 11:22:02,769 [salt.state       ][INFO    ][23254] Executing state pkg.installed for keepalived
2017-12-02 11:22:02,785 [salt.loaded.int.module.cmdmod][INFO    ][23254] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-02 11:22:04,052 [salt.loaded.int.module.cmdmod][INFO    ][23254] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-12-02 11:22:06,694 [salt.loaded.int.module.cmdmod][INFO    ][23254] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 11:22:06,720 [salt.state       ][INFO    ][23254] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-12-02 11:22:06,731 [salt.state       ][INFO    ][23254] Loading fresh modules for state activity
2017-12-02 11:22:06,747 [salt.state       ][INFO    ][23254] Completed state [keepalived] at time 11:22:06.747077 duration_in_ms=3978.446
2017-12-02 11:22:06,749 [salt.state       ][INFO    ][23254] Running state [/etc/keepalived/keepalived.conf] at time 11:22:06.749353
2017-12-02 11:22:06,750 [salt.state       ][INFO    ][23254] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-02 11:22:06,782 [salt.fileclient  ][INFO    ][23254] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-02 11:22:06,825 [salt.fileclient  ][INFO    ][23254] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-02 11:22:06,834 [salt.state       ][INFO    ][23254] File changed:
New file
2017-12-02 11:22:06,834 [salt.state       ][INFO    ][23254] Completed state [/etc/keepalived/keepalived.conf] at time 11:22:06.833663 duration_in_ms=84.309
2017-12-02 11:22:06,903 [salt.state       ][INFO    ][23254] Running state [keepalived] at time 11:22:06.903401
2017-12-02 11:22:06,904 [salt.state       ][INFO    ][23254] Executing state service.running for keepalived
2017-12-02 11:22:06,905 [salt.loaded.int.module.cmdmod][INFO    ][23254] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-02 11:22:06,914 [salt.loaded.int.module.cmdmod][INFO    ][23254] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-02 11:22:06,920 [salt.loaded.int.module.cmdmod][INFO    ][23254] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-02 11:22:06,928 [salt.loaded.int.module.cmdmod][INFO    ][23254] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-02 11:22:06,936 [salt.loaded.int.module.cmdmod][INFO    ][23254] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-12-02 11:22:06,966 [salt.loaded.int.module.cmdmod][INFO    ][23254] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-02 11:22:06,975 [salt.loaded.int.module.cmdmod][INFO    ][23254] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-02 11:22:06,983 [salt.loaded.int.module.cmdmod][INFO    ][23254] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-02 11:22:06,990 [salt.state       ][INFO    ][23254] {'keepalived': True}
2017-12-02 11:22:06,990 [salt.state       ][INFO    ][23254] Completed state [keepalived] at time 11:22:06.990415 duration_in_ms=87.013
2017-12-02 11:22:06,991 [salt.minion      ][INFO    ][23254] Returning information for job: 20171202112201500318
2017-12-02 11:23:44,718 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command pillar.get with jid 20171202112344706124
2017-12-02 11:23:44,732 [salt.minion      ][INFO    ][24728] Starting a new job with PID 24728
2017-12-02 11:23:44,736 [salt.minion      ][INFO    ][24728] Returning information for job: 20171202112344706124
2017-12-02 11:28:31,152 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command state.sls with jid 20171202112831138533
2017-12-02 11:28:31,164 [salt.minion      ][INFO    ][24818] Starting a new job with PID 24818
2017-12-02 11:28:33,764 [salt.state       ][INFO    ][24818] Loading fresh modules for state activity
2017-12-02 11:28:33,794 [salt.fileclient  ][INFO    ][24818] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-02 11:28:33,818 [salt.fileclient  ][INFO    ][24818] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-02 11:28:34,128 [salt.state       ][INFO    ][24818] Running state [attr] at time 11:28:34.127847
2017-12-02 11:28:34,128 [salt.state       ][INFO    ][24818] Executing state pkg.installed for attr
2017-12-02 11:28:34,129 [salt.loaded.int.module.cmdmod][INFO    ][24818] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 11:28:34,391 [salt.loaded.int.module.cmdmod][INFO    ][24818] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-02 11:28:35,701 [salt.loaded.int.module.cmdmod][INFO    ][24818] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-12-02 11:28:37,048 [salt.loaded.int.module.cmdmod][INFO    ][24818] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 11:28:37,077 [salt.state       ][INFO    ][24818] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-12-02 11:28:37,088 [salt.state       ][INFO    ][24818] Loading fresh modules for state activity
2017-12-02 11:28:37,105 [salt.state       ][INFO    ][24818] Completed state [attr] at time 11:28:37.105010 duration_in_ms=2977.162
2017-12-02 11:28:37,111 [salt.state       ][INFO    ][24818] Running state [glusterfs-server] at time 11:28:37.110609
2017-12-02 11:28:37,111 [salt.state       ][INFO    ][24818] Executing state pkg.installed for glusterfs-server
2017-12-02 11:28:37,335 [salt.loaded.int.module.cmdmod][INFO    ][24818] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-12-02 11:28:41,263 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command saltutil.find_job with jid 20171202112841245103
2017-12-02 11:28:41,275 [salt.minion      ][INFO    ][25700] Starting a new job with PID 25700
2017-12-02 11:28:41,290 [salt.minion      ][INFO    ][25700] Returning information for job: 20171202112841245103
2017-12-02 11:28:47,749 [salt.loaded.int.module.cmdmod][INFO    ][24818] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 11:28:47,779 [salt.state       ][INFO    ][24818] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'glusterfs-client' changed from 'absent' to '3.10.8-ubuntu1~xenial1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.2'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'glusterfs-common' changed from 'absent' to '3.10.8-ubuntu1~xenial1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'portmap' changed from 'absent' to '1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'
'nfs-client' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.10.8-ubuntu1~xenial1'

2017-12-02 11:28:47,789 [salt.state       ][INFO    ][24818] Loading fresh modules for state activity
2017-12-02 11:28:47,807 [salt.state       ][INFO    ][24818] Completed state [glusterfs-server] at time 11:28:47.807343 duration_in_ms=10696.734
2017-12-02 11:28:47,813 [salt.state       ][INFO    ][24818] Running state [bc] at time 11:28:47.812662
2017-12-02 11:28:47,813 [salt.state       ][INFO    ][24818] Executing state pkg.installed for bc
2017-12-02 11:28:48,104 [salt.loaded.int.module.cmdmod][INFO    ][24818] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-12-02 11:28:49,578 [salt.loaded.int.module.cmdmod][INFO    ][24818] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 11:28:49,607 [salt.state       ][INFO    ][24818] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-12-02 11:28:49,619 [salt.state       ][INFO    ][24818] Loading fresh modules for state activity
2017-12-02 11:28:49,638 [salt.state       ][INFO    ][24818] Completed state [bc] at time 11:28:49.637905 duration_in_ms=1825.243
2017-12-02 11:28:49,711 [salt.state       ][INFO    ][24818] Running state [glusterfs-server] at time 11:28:49.711406
2017-12-02 11:28:49,712 [salt.state       ][INFO    ][24818] Executing state service.running for glusterfs-server
2017-12-02 11:28:49,713 [salt.loaded.int.module.cmdmod][INFO    ][24818] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-02 11:28:49,723 [salt.loaded.int.module.cmdmod][INFO    ][24818] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-02 11:28:49,729 [salt.loaded.int.module.cmdmod][INFO    ][24818] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-02 11:28:49,737 [salt.state       ][INFO    ][24818] The service glusterfs-server is already running
2017-12-02 11:28:49,737 [salt.state       ][INFO    ][24818] Completed state [glusterfs-server] at time 11:28:49.737391 duration_in_ms=25.985
2017-12-02 11:28:49,739 [salt.state       ][INFO    ][24818] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 11:28:49.738937
2017-12-02 11:28:49,739 [salt.state       ][INFO    ][24818] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-02 11:28:49,744 [salt.state       ][INFO    ][24818] File changed:
New file
2017-12-02 11:28:49,744 [salt.state       ][INFO    ][24818] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 11:28:49.744211 duration_in_ms=5.275
2017-12-02 11:28:49,744 [salt.state       ][INFO    ][24818] Running state [/srv/glusterfs/glance] at time 11:28:49.744406
2017-12-02 11:28:49,745 [salt.state       ][INFO    ][24818] Executing state file.directory for /srv/glusterfs/glance
2017-12-02 11:28:49,745 [salt.state       ][INFO    ][24818] {'/srv/glusterfs/glance': 'New Dir'}
2017-12-02 11:28:49,745 [salt.state       ][INFO    ][24818] Completed state [/srv/glusterfs/glance] at time 11:28:49.745449 duration_in_ms=1.042
2017-12-02 11:28:49,746 [salt.state       ][INFO    ][24818] Running state [/srv/glusterfs/keystone-keys] at time 11:28:49.745627
2017-12-02 11:28:49,746 [salt.state       ][INFO    ][24818] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-02 11:28:49,746 [salt.state       ][INFO    ][24818] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-12-02 11:28:49,747 [salt.state       ][INFO    ][24818] Completed state [/srv/glusterfs/keystone-keys] at time 11:28:49.746515 duration_in_ms=0.888
2017-12-02 11:28:49,747 [salt.state       ][INFO    ][24818] Running state [/srv/glusterfs/nova_instances] at time 11:28:49.746690
2017-12-02 11:28:49,747 [salt.state       ][INFO    ][24818] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-02 11:28:49,747 [salt.state       ][INFO    ][24818] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-12-02 11:28:49,748 [salt.state       ][INFO    ][24818] Completed state [/srv/glusterfs/nova_instances] at time 11:28:49.747482 duration_in_ms=0.791
2017-12-02 11:28:49,748 [salt.state       ][INFO    ][24818] Running state [/srv/glusterfs/keystone-credential-keys] at time 11:28:49.747664
2017-12-02 11:28:49,748 [salt.state       ][INFO    ][24818] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-02 11:28:49,748 [salt.state       ][INFO    ][24818] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-12-02 11:28:49,748 [salt.state       ][INFO    ][24818] Completed state [/srv/glusterfs/keystone-credential-keys] at time 11:28:49.748450 duration_in_ms=0.786
2017-12-02 11:28:49,749 [salt.minion      ][INFO    ][24818] Returning information for job: 20171202112831138533
2017-12-02 11:28:51,572 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command test.ping with jid 20171202112851558423
2017-12-02 11:28:51,584 [salt.minion      ][INFO    ][27671] Starting a new job with PID 27671
2017-12-02 11:28:51,621 [salt.minion      ][INFO    ][27671] Returning information for job: 20171202112851558423
2017-12-02 11:29:10,270 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command state.sls with jid 20171202112910256361
2017-12-02 11:29:10,282 [salt.minion      ][INFO    ][28304] Starting a new job with PID 28304
2017-12-02 11:29:12,610 [salt.state       ][INFO    ][28304] Loading fresh modules for state activity
2017-12-02 11:29:12,642 [salt.fileclient  ][INFO    ][28304] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-02 11:29:12,693 [salt.fileclient  ][INFO    ][28304] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-02 11:29:12,784 [salt.fileclient  ][INFO    ][28304] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-02 11:29:12,807 [salt.fileclient  ][INFO    ][28304] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-02 11:29:13,118 [salt.state       ][INFO    ][28304] Running state [attr] at time 11:29:13.117485
2017-12-02 11:29:13,118 [salt.state       ][INFO    ][28304] Executing state pkg.installed for attr
2017-12-02 11:29:13,118 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-02 11:29:13,399 [salt.state       ][INFO    ][28304] Package attr is already installed
2017-12-02 11:29:13,399 [salt.state       ][INFO    ][28304] Completed state [attr] at time 11:29:13.399039 duration_in_ms=281.555
2017-12-02 11:29:13,399 [salt.state       ][INFO    ][28304] Running state [glusterfs-server] at time 11:29:13.399274
2017-12-02 11:29:13,399 [salt.state       ][INFO    ][28304] Executing state pkg.installed for glusterfs-server
2017-12-02 11:29:13,403 [salt.state       ][INFO    ][28304] Package glusterfs-server is already installed
2017-12-02 11:29:13,403 [salt.state       ][INFO    ][28304] Completed state [glusterfs-server] at time 11:29:13.403177 duration_in_ms=3.903
2017-12-02 11:29:13,403 [salt.state       ][INFO    ][28304] Running state [bc] at time 11:29:13.403343
2017-12-02 11:29:13,404 [salt.state       ][INFO    ][28304] Executing state pkg.installed for bc
2017-12-02 11:29:13,407 [salt.state       ][INFO    ][28304] Package bc is already installed
2017-12-02 11:29:13,407 [salt.state       ][INFO    ][28304] Completed state [bc] at time 11:29:13.407154 duration_in_ms=3.811
2017-12-02 11:29:13,408 [salt.state       ][INFO    ][28304] Running state [glusterfs-server] at time 11:29:13.408098
2017-12-02 11:29:13,408 [salt.state       ][INFO    ][28304] Executing state service.running for glusterfs-server
2017-12-02 11:29:13,409 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-02 11:29:13,418 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-02 11:29:13,467 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-02 11:29:13,483 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-02 11:29:13,489 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-02 11:29:13,497 [salt.state       ][INFO    ][28304] The service glusterfs-server is already running
2017-12-02 11:29:13,497 [salt.state       ][INFO    ][28304] Completed state [glusterfs-server] at time 11:29:13.496867 duration_in_ms=88.768
2017-12-02 11:29:13,499 [salt.state       ][INFO    ][28304] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 11:29:13.498539
2017-12-02 11:29:13,499 [salt.state       ][INFO    ][28304] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-02 11:29:13,501 [salt.state       ][INFO    ][28304] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-02 11:29:13,501 [salt.state       ][INFO    ][28304] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 11:29:13.501016 duration_in_ms=2.477
2017-12-02 11:29:13,501 [salt.state       ][INFO    ][28304] Running state [/srv/glusterfs/glance] at time 11:29:13.501249
2017-12-02 11:29:13,501 [salt.state       ][INFO    ][28304] Executing state file.directory for /srv/glusterfs/glance
2017-12-02 11:29:13,502 [salt.state       ][INFO    ][28304] Directory /srv/glusterfs/glance is in the correct state
2017-12-02 11:29:13,502 [salt.state       ][INFO    ][28304] Completed state [/srv/glusterfs/glance] at time 11:29:13.502061 duration_in_ms=0.812
2017-12-02 11:29:13,502 [salt.state       ][INFO    ][28304] Running state [/srv/glusterfs/keystone-keys] at time 11:29:13.502274
2017-12-02 11:29:13,502 [salt.state       ][INFO    ][28304] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-02 11:29:13,503 [salt.state       ][INFO    ][28304] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-02 11:29:13,503 [salt.state       ][INFO    ][28304] Completed state [/srv/glusterfs/keystone-keys] at time 11:29:13.502995 duration_in_ms=0.72
2017-12-02 11:29:13,503 [salt.state       ][INFO    ][28304] Running state [/srv/glusterfs/nova_instances] at time 11:29:13.503208
2017-12-02 11:29:13,503 [salt.state       ][INFO    ][28304] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-02 11:29:13,504 [salt.state       ][INFO    ][28304] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-02 11:29:13,504 [salt.state       ][INFO    ][28304] Completed state [/srv/glusterfs/nova_instances] at time 11:29:13.503972 duration_in_ms=0.764
2017-12-02 11:29:13,504 [salt.state       ][INFO    ][28304] Running state [/srv/glusterfs/keystone-credential-keys] at time 11:29:13.504166
2017-12-02 11:29:13,504 [salt.state       ][INFO    ][28304] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-02 11:29:13,505 [salt.state       ][INFO    ][28304] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-02 11:29:13,505 [salt.state       ][INFO    ][28304] Completed state [/srv/glusterfs/keystone-credential-keys] at time 11:29:13.504893 duration_in_ms=0.728
2017-12-02 11:29:13,613 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command ['git', '--version'] in directory '/root'
2017-12-02 11:29:13,668 [salt.state       ][INFO    ][28304] Running state [sleep 5] at time 11:29:13.667963
2017-12-02 11:29:13,668 [salt.state       ][INFO    ][28304] Executing state cmd.wait for sleep 5
2017-12-02 11:29:13,669 [salt.state       ][INFO    ][28304] No changes made for sleep 5
2017-12-02 11:29:13,669 [salt.state       ][INFO    ][28304] Completed state [sleep 5] at time 11:29:13.668710 duration_in_ms=0.748
2017-12-02 11:29:13,669 [salt.state       ][INFO    ][28304] Running state [192.168.10.143] at time 11:29:13.669332
2017-12-02 11:29:13,670 [salt.state       ][INFO    ][28304] Executing state glusterfs.peered for 192.168.10.143
2017-12-02 11:29:13,670 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:13,679 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:13,735 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:13,744 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:13,800 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:13,809 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:13,864 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:13,871 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:13,930 [salt.state       ][INFO    ][28304] Peering with localhost is not needed
2017-12-02 11:29:13,930 [salt.state       ][INFO    ][28304] Completed state [192.168.10.143] at time 11:29:13.929844 duration_in_ms=260.51
2017-12-02 11:29:13,933 [salt.state       ][INFO    ][28304] Running state [192.168.10.142] at time 11:29:13.933236
2017-12-02 11:29:13,934 [salt.state       ][INFO    ][28304] Executing state glusterfs.peered for 192.168.10.142
2017-12-02 11:29:13,934 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:13,942 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:13,997 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:14,005 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:14,062 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:14,071 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:14,127 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:14,135 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:14,190 [salt.state       ][INFO    ][28304] {'new': {'192.168.10.141': [], 'kvm02.baremetal-mcp-ocata-odl-ha.local': ['192.168.10.142']}, 'old': {'192.168.10.141': [], 'kvm02.baremetal-mcp-ocata-odl-ha.local': []}}
2017-12-02 11:29:14,190 [salt.state       ][INFO    ][28304] Completed state [192.168.10.142] at time 11:29:14.190143 duration_in_ms=256.904
2017-12-02 11:29:14,193 [salt.state       ][INFO    ][28304] Running state [192.168.10.141] at time 11:29:14.193416
2017-12-02 11:29:14,194 [salt.state       ][INFO    ][28304] Executing state glusterfs.peered for 192.168.10.141
2017-12-02 11:29:14,194 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:14,203 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:14,258 [salt.state       ][INFO    ][28304] Host 192.168.10.141 already peered
2017-12-02 11:29:14,258 [salt.state       ][INFO    ][28304] Completed state [192.168.10.141] at time 11:29:14.257753 duration_in_ms=64.337
2017-12-02 11:29:14,259 [salt.state       ][INFO    ][28304] Running state [glance] at time 11:29:14.258868
2017-12-02 11:29:14,259 [salt.state       ][INFO    ][28304] Executing state glusterfs.created for glance
2017-12-02 11:29:14,260 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:14,268 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:14,322 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:14,330 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:14,388 [salt.state       ][INFO    ][28304] Volume glance already exists and is started.
2017-12-02 11:29:14,389 [salt.state       ][INFO    ][28304] Completed state [glance] at time 11:29:14.388460 duration_in_ms=129.591
2017-12-02 11:29:14,393 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 11:29:14.392885
2017-12-02 11:29:14,393 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-02 11:29:14,394 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-02 11:29:14,449 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:14,449 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 11:29:14.449047 duration_in_ms=56.162
2017-12-02 11:29:14,450 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 11:29:14.449678
2017-12-02 11:29:14,452 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-02 11:29:14,454 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-02 11:29:14,512 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:14,512 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 11:29:14.512302 duration_in_ms=62.624
2017-12-02 11:29:14,514 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 11:29:14.513558
2017-12-02 11:29:14,514 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-02 11:29:14,514 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-02 11:29:14,574 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:14,574 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 11:29:14.573743 duration_in_ms=60.185
2017-12-02 11:29:14,575 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 11:29:14.574476
2017-12-02 11:29:14,575 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-02 11:29:14,575 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-02 11:29:14,632 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:14,632 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 11:29:14.632265 duration_in_ms=57.789
2017-12-02 11:29:14,633 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 11:29:14.632878
2017-12-02 11:29:14,633 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-02 11:29:14,634 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-02 11:29:14,691 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:14,691 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 11:29:14.691379 duration_in_ms=58.502
2017-12-02 11:29:14,692 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 11:29:14.691977
2017-12-02 11:29:14,692 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-02 11:29:14,693 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-02 11:29:14,751 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:14,751 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 11:29:14.750985 duration_in_ms=59.008
2017-12-02 11:29:14,753 [salt.state       ][INFO    ][28304] Running state [glance] at time 11:29:14.752665
2017-12-02 11:29:14,753 [salt.state       ][INFO    ][28304] Executing state glusterfs.started for glance
2017-12-02 11:29:14,754 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:14,763 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:14,819 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:14,827 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:14,890 [salt.state       ][INFO    ][28304] Volume glance is already started
2017-12-02 11:29:14,890 [salt.state       ][INFO    ][28304] Completed state [glance] at time 11:29:14.890152 duration_in_ms=137.487
2017-12-02 11:29:14,891 [salt.state       ][INFO    ][28304] Running state [keystone-keys] at time 11:29:14.891437
2017-12-02 11:29:14,892 [salt.state       ][INFO    ][28304] Executing state glusterfs.created for keystone-keys
2017-12-02 11:29:14,892 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:14,901 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:14,958 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:14,968 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:15,027 [salt.state       ][INFO    ][28304] Volume keystone-keys already exists and is started.
2017-12-02 11:29:15,028 [salt.state       ][INFO    ][28304] Completed state [keystone-keys] at time 11:29:15.027482 duration_in_ms=136.043
2017-12-02 11:29:15,033 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 11:29:15.032860
2017-12-02 11:29:15,033 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-02 11:29:15,034 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-02 11:29:15,091 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:15,091 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 11:29:15.090810 duration_in_ms=57.948
2017-12-02 11:29:15,092 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 11:29:15.091560
2017-12-02 11:29:15,092 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-02 11:29:15,092 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-02 11:29:15,148 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:15,149 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 11:29:15.148561 duration_in_ms=57.001
2017-12-02 11:29:15,149 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 11:29:15.149143
2017-12-02 11:29:15,149 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-02 11:29:15,150 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-02 11:29:15,207 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:15,207 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 11:29:15.207068 duration_in_ms=57.925
2017-12-02 11:29:15,208 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 11:29:15.207647
2017-12-02 11:29:15,208 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-02 11:29:15,208 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-02 11:29:15,265 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:15,265 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 11:29:15.264901 duration_in_ms=57.253
2017-12-02 11:29:15,266 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 11:29:15.265510
2017-12-02 11:29:15,266 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-02 11:29:15,266 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-02 11:29:15,324 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:15,324 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 11:29:15.324023 duration_in_ms=58.512
2017-12-02 11:29:15,325 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 11:29:15.324666
2017-12-02 11:29:15,325 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-02 11:29:15,326 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-02 11:29:15,380 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:15,380 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 11:29:15.380019 duration_in_ms=55.352
2017-12-02 11:29:15,382 [salt.state       ][INFO    ][28304] Running state [keystone-keys] at time 11:29:15.381499
2017-12-02 11:29:15,382 [salt.state       ][INFO    ][28304] Executing state glusterfs.started for keystone-keys
2017-12-02 11:29:15,382 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:15,390 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:15,446 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:15,454 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:15,520 [salt.state       ][INFO    ][28304] Volume keystone-keys is already started
2017-12-02 11:29:15,520 [salt.state       ][INFO    ][28304] Completed state [keystone-keys] at time 11:29:15.520427 duration_in_ms=138.927
2017-12-02 11:29:15,522 [salt.state       ][INFO    ][28304] Running state [nova_instances] at time 11:29:15.521598
2017-12-02 11:29:15,522 [salt.state       ][INFO    ][28304] Executing state glusterfs.created for nova_instances
2017-12-02 11:29:15,522 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:15,530 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:15,587 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:15,596 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:15,656 [salt.state       ][INFO    ][28304] Volume nova_instances already exists and is started.
2017-12-02 11:29:15,656 [salt.state       ][INFO    ][28304] Completed state [nova_instances] at time 11:29:15.656212 duration_in_ms=134.613
2017-12-02 11:29:15,661 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 11:29:15.660744
2017-12-02 11:29:15,661 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-02 11:29:15,661 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-02 11:29:15,719 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:15,719 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 11:29:15.718765 duration_in_ms=58.011
2017-12-02 11:29:15,719 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 11:29:15.719341
2017-12-02 11:29:15,720 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-02 11:29:15,720 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-02 11:29:15,776 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:15,776 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 11:29:15.776200 duration_in_ms=56.859
2017-12-02 11:29:15,777 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 11:29:15.776806
2017-12-02 11:29:15,777 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-02 11:29:15,778 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-02 11:29:15,835 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:15,836 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 11:29:15.835571 duration_in_ms=58.764
2017-12-02 11:29:15,836 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 11:29:15.836205
2017-12-02 11:29:15,836 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-02 11:29:15,837 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-02 11:29:15,893 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:15,893 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 11:29:15.892860 duration_in_ms=56.654
2017-12-02 11:29:15,894 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 11:29:15.893506
2017-12-02 11:29:15,894 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-02 11:29:15,894 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-02 11:29:15,951 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:15,951 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 11:29:15.950943 duration_in_ms=57.436
2017-12-02 11:29:15,952 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 11:29:15.951577
2017-12-02 11:29:15,952 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-02 11:29:15,952 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-02 11:29:16,009 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:16,009 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 11:29:16.008973 duration_in_ms=57.395
2017-12-02 11:29:16,011 [salt.state       ][INFO    ][28304] Running state [nova_instances] at time 11:29:16.010633
2017-12-02 11:29:16,011 [salt.state       ][INFO    ][28304] Executing state glusterfs.started for nova_instances
2017-12-02 11:29:16,012 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:16,021 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:16,080 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:16,087 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:16,147 [salt.state       ][INFO    ][28304] Volume nova_instances is already started
2017-12-02 11:29:16,147 [salt.state       ][INFO    ][28304] Completed state [nova_instances] at time 11:29:16.147215 duration_in_ms=136.581
2017-12-02 11:29:16,148 [salt.state       ][INFO    ][28304] Running state [keystone-credential-keys] at time 11:29:16.148427
2017-12-02 11:29:16,149 [salt.state       ][INFO    ][28304] Executing state glusterfs.created for keystone-credential-keys
2017-12-02 11:29:16,149 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:16,158 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:16,218 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:16,227 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:16,289 [salt.state       ][INFO    ][28304] Volume keystone-credential-keys already exists and is started.
2017-12-02 11:29:16,289 [salt.state       ][INFO    ][28304] Completed state [keystone-credential-keys] at time 11:29:16.289366 duration_in_ms=140.939
2017-12-02 11:29:16,294 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 11:29:16.294428
2017-12-02 11:29:16,295 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-02 11:29:16,295 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-02 11:29:16,352 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:16,352 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 11:29:16.351719 duration_in_ms=57.291
2017-12-02 11:29:16,352 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 11:29:16.352272
2017-12-02 11:29:16,353 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-02 11:29:16,353 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-02 11:29:16,410 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:16,411 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 11:29:16.410568 duration_in_ms=58.296
2017-12-02 11:29:16,411 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 11:29:16.411141
2017-12-02 11:29:16,411 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-02 11:29:16,412 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-02 11:29:16,468 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:16,468 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 11:29:16.468031 duration_in_ms=56.888
2017-12-02 11:29:16,469 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 11:29:16.468674
2017-12-02 11:29:16,469 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-02 11:29:16,470 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-02 11:29:16,527 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:16,527 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 11:29:16.527442 duration_in_ms=58.768
2017-12-02 11:29:16,528 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 11:29:16.528031
2017-12-02 11:29:16,528 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-02 11:29:16,529 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-02 11:29:16,584 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:16,584 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 11:29:16.583841 duration_in_ms=55.81
2017-12-02 11:29:16,584 [salt.state       ][INFO    ][28304] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 11:29:16.584437
2017-12-02 11:29:16,585 [salt.state       ][INFO    ][28304] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-02 11:29:16,585 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-02 11:29:16,642 [salt.state       ][INFO    ][28304] unless execution succeeded
2017-12-02 11:29:16,642 [salt.state       ][INFO    ][28304] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 11:29:16.641882 duration_in_ms=57.445
2017-12-02 11:29:16,643 [salt.state       ][INFO    ][28304] Running state [keystone-credential-keys] at time 11:29:16.643420
2017-12-02 11:29:16,644 [salt.state       ][INFO    ][28304] Executing state glusterfs.started for keystone-credential-keys
2017-12-02 11:29:16,644 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:16,652 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:16,711 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --version' in directory '/root'
2017-12-02 11:29:16,717 [salt.loaded.int.module.cmdmod][INFO    ][28304] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-02 11:29:16,778 [salt.state       ][INFO    ][28304] Volume keystone-credential-keys is already started
2017-12-02 11:29:16,779 [salt.state       ][INFO    ][28304] Completed state [keystone-credential-keys] at time 11:29:16.778600 duration_in_ms=135.18
2017-12-02 11:29:16,781 [salt.minion      ][INFO    ][28304] Returning information for job: 20171202112910256361
2017-12-02 11:29:22,760 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command test.ping with jid 20171202112922746979
2017-12-02 11:29:22,772 [salt.minion      ][INFO    ][28864] Starting a new job with PID 28864
2017-12-02 11:29:22,808 [salt.minion      ][INFO    ][28864] Returning information for job: 20171202112922746979
2017-12-02 11:29:23,201 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command cmd.run with jid 20171202112923184172
2017-12-02 11:29:23,213 [salt.minion      ][INFO    ][28869] Starting a new job with PID 28869
2017-12-02 11:29:23,217 [salt.loaded.int.module.cmdmod][INFO    ][28869] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-02 11:29:23,336 [salt.minion      ][INFO    ][28869] Returning information for job: 20171202112923184172
2017-12-02 12:00:24,201 [salt.utils.schedule][INFO    ][22411] Running scheduled job: __mine_interval
2017-12-02 12:30:14,662 [salt.minion      ][INFO    ][22411] User sudo_ubuntu Executing command cp.push_dir with jid 20171202123014649770
2017-12-02 12:30:14,679 [salt.minion      ][INFO    ][29775] Starting a new job with PID 29775
