2017-12-03 22:13:12,745 [salt.cli.daemons ][WARNING ][2060] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-03 22:14:20,640 [salt.state       ][ERROR   ][3679] No contents found in top file
2017-12-03 22:15:49,227 [salt.utils.parsers][WARNING ][2060] Minion received a SIGTERM. Exiting.
2017-12-03 22:20:17,583 [salt.cli.daemons ][WARNING ][3125] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-03 22:22:36,036 [py.warnings      ][WARNING ][13570] /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-03 22:23:18,360 [salt.loaded.int.module.cmdmod][ERROR   ][13570] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 22:23:18,361 [salt.loaded.int.module.cmdmod][ERROR   ][13570] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 22:23:22,847 [salt.loaded.int.module.cmdmod][ERROR   ][13570] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 22:23:22,848 [salt.loaded.int.module.cmdmod][ERROR   ][13570] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 22:23:27,291 [salt.loaded.int.module.cmdmod][ERROR   ][13570] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 22:23:27,291 [salt.loaded.int.module.cmdmod][ERROR   ][13570] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 22:23:31,728 [salt.loaded.int.module.cmdmod][ERROR   ][13570] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 22:23:31,728 [salt.loaded.int.module.cmdmod][ERROR   ][13570] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 22:23:35,250 [salt.loaded.int.module.cmdmod][ERROR   ][13570] 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-03 22:23:37,783 [salt.loaded.int.module.cmdmod][INFO    ][20668] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-03 22:23:37,790 [salt.loaded.int.module.cmdmod][INFO    ][20668] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-03 22:23:37,799 [salt.loaded.int.module.cmdmod][INFO    ][20668] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-03 22:23:37,807 [salt.utils.parsers][WARNING ][3125] Minion received a SIGTERM. Exiting.
2017-12-03 22:23:38,120 [salt.cli.daemons ][INFO    ][20743] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-ha.local"
2017-12-03 22:23:38,753 [salt.minion      ][INFO    ][20743] Creating minion process manager
2017-12-03 22:23:38,753 [salt.cli.daemons ][WARNING ][20743] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-03 22:23:38,753 [salt.cli.daemons ][INFO    ][20743] The Salt Minion is starting up
2017-12-03 22:23:38,754 [salt.minion      ][INFO    ][20743] Minion is starting as user 'root'
2017-12-03 22:23:38,754 [salt.utils.event ][INFO    ][20743] Starting pull socket on /var/run/salt/minion/minion_event_a1b2f32648_pull.ipc
2017-12-03 22:23:39,865 [salt.loaded.int.module.cmdmod][INFO    ][20743] Executing command ['date', '+%z'] in directory '/root'
2017-12-03 22:23:39,877 [salt.utils.schedule][INFO    ][20743] Updating job settings for scheduled job: __mine_interval
2017-12-03 22:23:39,880 [salt.minion      ][INFO    ][20743] Added mine.update to scheduler
2017-12-03 22:23:39,906 [salt.minion      ][INFO    ][20743] Minion is ready to receive requests!
2017-12-03 22:23:40,908 [salt.utils.schedule][INFO    ][20743] Running scheduled job: __mine_interval
2017-12-03 22:24:21,409 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171203222421400186
2017-12-03 22:24:21,421 [salt.minion      ][INFO    ][20843] Starting a new job with PID 20843
2017-12-03 22:24:23,811 [salt.state       ][INFO    ][20843] Loading fresh modules for state activity
2017-12-03 22:24:23,840 [salt.state       ][ERROR   ][20843] No contents found in top file
2017-12-03 22:24:23,840 [salt.utils.extmods][INFO    ][20843] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-03 22:24:23,844 [salt.utils.extmods][INFO    ][20843] Syncing beacons for environment 'base'
2017-12-03 22:24:23,844 [salt.utils.extmods][INFO    ][20843] Loading cache from salt://_beacons, for base)
2017-12-03 22:24:23,844 [salt.fileclient  ][INFO    ][20843] Caching directory '_beacons/' for environment 'base'
2017-12-03 22:24:23,878 [salt.utils.extmods][INFO    ][20843] Syncing modules for environment 'base'
2017-12-03 22:24:23,878 [salt.utils.extmods][INFO    ][20843] Loading cache from salt://_modules, for base)
2017-12-03 22:24:23,879 [salt.fileclient  ][INFO    ][20843] Caching directory '_modules/' for environment 'base'
2017-12-03 22:24:23,929 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-03 22:24:23,943 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-03 22:24:23,952 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-03 22:24:23,965 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-03 22:24:23,974 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-03 22:24:23,995 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-03 22:24:24,006 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-03 22:24:24,017 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-03 22:24:24,029 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-03 22:24:24,040 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-03 22:24:24,068 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-03 22:24:24,080 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-03 22:24:24,092 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-03 22:24:24,104 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-03 22:24:24,125 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-03 22:24:24,134 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-03 22:24:24,147 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-03 22:24:24,159 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-03 22:24:24,172 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-03 22:24:24,186 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-03 22:24:24,197 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-03 22:24:24,212 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-03 22:24:24,226 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-03 22:24:24,240 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-03 22:24:24,252 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-03 22:24:24,263 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-03 22:24:24,274 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-03 22:24:24,284 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-03 22:24:24,297 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-03 22:24:24,315 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-03 22:24:24,325 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-03 22:24:24,335 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-03 22:24:24,346 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-03 22:24:24,360 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-03 22:24:24,363 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-03 22:24:24,364 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-03 22:24:24,364 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-03 22:24:24,365 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-03 22:24:24,365 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-03 22:24:24,366 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-03 22:24:24,366 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-03 22:24:24,367 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-03 22:24:24,367 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-03 22:24:24,368 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-03 22:24:24,368 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-03 22:24:24,368 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-03 22:24:24,369 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-03 22:24:24,369 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-03 22:24:24,370 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-03 22:24:24,370 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-03 22:24:24,371 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-03 22:24:24,371 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-03 22:24:24,372 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-03 22:24:24,372 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-03 22:24:24,372 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-03 22:24:24,373 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-03 22:24:24,373 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-03 22:24:24,374 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-03 22:24:24,375 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-03 22:24:24,375 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-03 22:24:24,375 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-03 22:24:24,376 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-03 22:24:24,376 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-03 22:24:24,377 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-03 22:24:24,377 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-03 22:24:24,377 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-03 22:24:24,378 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-03 22:24:24,378 [salt.utils.extmods][INFO    ][20843] 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-03 22:24:24,379 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-03 22:24:24,379 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-03 22:24:24,385 [salt.utils.extmods][INFO    ][20843] Syncing states for environment 'base'
2017-12-03 22:24:24,385 [salt.utils.extmods][INFO    ][20843] Loading cache from salt://_states, for base)
2017-12-03 22:24:24,385 [salt.fileclient  ][INFO    ][20843] Caching directory '_states/' for environment 'base'
2017-12-03 22:24:24,432 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-03 22:24:24,443 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-03 22:24:24,456 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-03 22:24:24,467 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-03 22:24:24,478 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-03 22:24:24,488 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-03 22:24:24,498 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-03 22:24:24,507 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-03 22:24:24,516 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-03 22:24:24,525 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-03 22:24:24,535 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-03 22:24:24,545 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-03 22:24:24,556 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-03 22:24:25,048 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-03 22:24:25,062 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-03 22:24:25,079 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-03 22:24:25,093 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-03 22:24:25,104 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-03 22:24:25,114 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-03 22:24:25,126 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-03 22:24:25,138 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-03 22:24:25,148 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-03 22:24:25,159 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-03 22:24:25,172 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-03 22:24:25,183 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-03 22:24:25,195 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-03 22:24:25,212 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-03 22:24:25,222 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-03 22:24:25,236 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-03 22:24:25,249 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-03 22:24:25,259 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-03 22:24:25,270 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-03 22:24:25,274 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-03 22:24:25,274 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-03 22:24:25,274 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-03 22:24:25,275 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-03 22:24:25,275 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-03 22:24:25,275 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-03 22:24:25,275 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-03 22:24:25,276 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-03 22:24:25,276 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-03 22:24:25,276 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-03 22:24:25,276 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-03 22:24:25,277 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-03 22:24:25,277 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-03 22:24:25,277 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-03 22:24:25,277 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-03 22:24:25,278 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-03 22:24:25,278 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-03 22:24:25,278 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-03 22:24:25,278 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-03 22:24:25,278 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-03 22:24:25,279 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-03 22:24:25,279 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-03 22:24:25,279 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-03 22:24:25,279 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-03 22:24:25,280 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-03 22:24:25,280 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-03 22:24:25,280 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-03 22:24:25,280 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-03 22:24:25,281 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-03 22:24:25,281 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-03 22:24:25,281 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-03 22:24:25,281 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-03 22:24:25,282 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-03 22:24:25,284 [salt.utils.extmods][INFO    ][20843] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-03 22:24:25,287 [salt.utils.extmods][INFO    ][20843] Syncing sdb for environment 'base'
2017-12-03 22:24:25,287 [salt.utils.extmods][INFO    ][20843] Loading cache from salt://_sdb, for base)
2017-12-03 22:24:25,288 [salt.fileclient  ][INFO    ][20843] Caching directory '_sdb/' for environment 'base'
2017-12-03 22:24:25,320 [salt.utils.extmods][INFO    ][20843] Syncing grains for environment 'base'
2017-12-03 22:24:25,320 [salt.utils.extmods][INFO    ][20843] Loading cache from salt://_grains, for base)
2017-12-03 22:24:25,321 [salt.fileclient  ][INFO    ][20843] Caching directory '_grains/' for environment 'base'
2017-12-03 22:24:25,362 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-03 22:24:25,371 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-03 22:24:25,383 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-03 22:24:25,396 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-03 22:24:25,408 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-03 22:24:25,419 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-03 22:24:25,431 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-03 22:24:25,440 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-03 22:24:25,451 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-03 22:24:25,461 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-03 22:24:25,470 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-03 22:24:25,482 [salt.fileclient  ][INFO    ][20843] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-03 22:24:25,486 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-03 22:24:25,486 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-03 22:24:25,486 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-03 22:24:25,487 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-03 22:24:25,487 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-03 22:24:25,488 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-03 22:24:25,488 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-03 22:24:25,488 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-03 22:24:25,489 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-03 22:24:25,489 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-03 22:24:25,490 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-03 22:24:25,490 [salt.utils.extmods][INFO    ][20843] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-03 22:24:25,491 [salt.utils.extmods][INFO    ][20843] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-03 22:24:25,494 [salt.utils.extmods][INFO    ][20843] Syncing renderers for environment 'base'
2017-12-03 22:24:25,494 [salt.utils.extmods][INFO    ][20843] Loading cache from salt://_renderers, for base)
2017-12-03 22:24:25,494 [salt.fileclient  ][INFO    ][20843] Caching directory '_renderers/' for environment 'base'
2017-12-03 22:24:25,525 [salt.utils.extmods][INFO    ][20843] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-03 22:24:25,527 [salt.utils.extmods][INFO    ][20843] Syncing returners for environment 'base'
2017-12-03 22:24:25,528 [salt.utils.extmods][INFO    ][20843] Loading cache from salt://_returners, for base)
2017-12-03 22:24:25,528 [salt.fileclient  ][INFO    ][20843] Caching directory '_returners/' for environment 'base'
2017-12-03 22:24:25,559 [salt.utils.extmods][INFO    ][20843] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-03 22:24:25,562 [salt.utils.extmods][INFO    ][20843] Syncing output for environment 'base'
2017-12-03 22:24:25,562 [salt.utils.extmods][INFO    ][20843] Loading cache from salt://_output, for base)
2017-12-03 22:24:25,562 [salt.fileclient  ][INFO    ][20843] Caching directory '_output/' for environment 'base'
2017-12-03 22:24:25,592 [salt.utils.extmods][INFO    ][20843] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-03 22:24:25,595 [salt.utils.extmods][INFO    ][20843] Syncing utils for environment 'base'
2017-12-03 22:24:25,595 [salt.utils.extmods][INFO    ][20843] Loading cache from salt://_utils, for base)
2017-12-03 22:24:25,595 [salt.fileclient  ][INFO    ][20843] Caching directory '_utils/' for environment 'base'
2017-12-03 22:24:25,629 [salt.utils.extmods][INFO    ][20843] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-03 22:24:25,632 [salt.utils.extmods][INFO    ][20843] Syncing log_handlers for environment 'base'
2017-12-03 22:24:25,632 [salt.utils.extmods][INFO    ][20843] Loading cache from salt://_log_handlers, for base)
2017-12-03 22:24:25,632 [salt.fileclient  ][INFO    ][20843] Caching directory '_log_handlers/' for environment 'base'
2017-12-03 22:24:25,666 [salt.utils.extmods][INFO    ][20843] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-03 22:24:25,669 [salt.utils.extmods][INFO    ][20843] Syncing proxy for environment 'base'
2017-12-03 22:24:25,669 [salt.utils.extmods][INFO    ][20843] Loading cache from salt://_proxy, for base)
2017-12-03 22:24:25,669 [salt.fileclient  ][INFO    ][20843] Caching directory '_proxy/' for environment 'base'
2017-12-03 22:24:25,698 [salt.utils.extmods][INFO    ][20843] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-03 22:24:25,701 [salt.utils.extmods][INFO    ][20843] Syncing engines for environment 'base'
2017-12-03 22:24:25,701 [salt.utils.extmods][INFO    ][20843] Loading cache from salt://_engines, for base)
2017-12-03 22:24:25,702 [salt.fileclient  ][INFO    ][20843] Caching directory '_engines/' for environment 'base'
2017-12-03 22:24:25,736 [salt.minion      ][INFO    ][20843] Returning information for job: 20171203222421400186
2017-12-03 22:24:27,373 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command state.sls with jid 20171203222426901310
2017-12-03 22:24:27,383 [salt.minion      ][INFO    ][20938] Starting a new job with PID 20938
2017-12-03 22:24:27,985 [salt.state       ][INFO    ][20938] Loading fresh modules for state activity
2017-12-03 22:24:28,012 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-03 22:24:28,032 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-03 22:24:28,103 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:24:28,183 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-03 22:24:28,199 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-03 22:24:28,231 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:24:28,302 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-03 22:24:28,323 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 22:24:28,382 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-03 22:24:28,404 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-03 22:24:28,418 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 22:24:28,434 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-03 22:24:28,444 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-03 22:24:28,464 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-03 22:24:28,483 [py.warnings      ][WARNING ][20938] /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-03 22:24:28,483 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'salt-minion --version' in directory '/root'
2017-12-03 22:24:28,736 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-03 22:24:28,751 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-03 22:24:28,762 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-03 22:24:28,774 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-03 22:24:28,815 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-03 22:24:28,827 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-03 22:24:28,847 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-03 22:24:28,857 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-03 22:24:28,874 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-03 22:24:28,904 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-03 22:24:28,972 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-03 22:24:28,993 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:24:29,054 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-03 22:24:29,072 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 22:24:29,127 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-03 22:24:29,147 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-03 22:24:29,164 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 22:24:29,183 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-03 22:24:29,192 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-03 22:24:29,214 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-03 22:24:29,233 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'salt-minion --version' in directory '/root'
2017-12-03 22:24:29,493 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-03 22:24:29,512 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-03 22:24:29,524 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-03 22:24:29,537 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-03 22:24:29,580 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-03 22:24:29,596 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-03 22:24:29,620 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-03 22:24:29,635 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-03 22:24:29,655 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-03 22:24:29,692 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-03 22:24:29,771 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-03 22:24:29,855 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:24:30,243 [salt.state       ][INFO    ][20938] Running state [salt-minion] at time 22:24:30.242778
2017-12-03 22:24:30,243 [salt.state       ][INFO    ][20938] Executing state pkg.installed for salt-minion
2017-12-03 22:24:30,244 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:24:30,512 [salt.state       ][INFO    ][20938] Package salt-minion is already installed
2017-12-03 22:24:30,513 [salt.state       ][INFO    ][20938] Completed state [salt-minion] at time 22:24:30.512803 duration_in_ms=270.025
2017-12-03 22:24:30,513 [salt.state       ][INFO    ][20938] Running state [salt_minion_dependency_packages] at time 22:24:30.513091
2017-12-03 22:24:30,513 [salt.state       ][INFO    ][20938] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-03 22:24:30,517 [salt.state       ][INFO    ][20938] All specified packages are already installed
2017-12-03 22:24:30,517 [salt.state       ][INFO    ][20938] Completed state [salt_minion_dependency_packages] at time 22:24:30.517287 duration_in_ms=4.195
2017-12-03 22:24:30,519 [salt.state       ][INFO    ][20938] Running state [/etc/salt/minion.d/minion.conf] at time 22:24:30.518984
2017-12-03 22:24:30,519 [salt.state       ][INFO    ][20938] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-03 22:24:30,537 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-03 22:24:30,598 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:24:30,651 [salt.fileclient  ][INFO    ][20938] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 22:24:30,699 [salt.state       ][INFO    ][20938] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-03 22:24:30,699 [salt.state       ][INFO    ][20938] Completed state [/etc/salt/minion.d/minion.conf] at time 22:24:30.698709 duration_in_ms=179.724
2017-12-03 22:24:30,699 [salt.state       ][INFO    ][20938] Running state [/etc/salt/minion.d/_virt.conf] at time 22:24:30.699086
2017-12-03 22:24:30,699 [salt.state       ][INFO    ][20938] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-03 22:24:30,700 [salt.state       ][INFO    ][20938] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-03 22:24:30,700 [salt.state       ][INFO    ][20938] Completed state [/etc/salt/minion.d/_virt.conf] at time 22:24:30.700137 duration_in_ms=1.05
2017-12-03 22:24:30,702 [salt.state       ][INFO    ][20938] Running state [salt-minion] at time 22:24:30.701851
2017-12-03 22:24:30,702 [salt.state       ][INFO    ][20938] Executing state service.running for salt-minion
2017-12-03 22:24:30,703 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-03 22:24:30,716 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-03 22:24:30,722 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-03 22:24:30,728 [salt.state       ][INFO    ][20938] The service salt-minion is already running
2017-12-03 22:24:30,728 [salt.state       ][INFO    ][20938] Completed state [salt-minion] at time 22:24:30.728262 duration_in_ms=26.411
2017-12-03 22:24:30,730 [salt.state       ][INFO    ][20938] Running state [/etc/salt/grains.d] at time 22:24:30.729857
2017-12-03 22:24:30,730 [salt.state       ][INFO    ][20938] Executing state file.directory for /etc/salt/grains.d
2017-12-03 22:24:30,731 [salt.state       ][INFO    ][20938] Directory /etc/salt/grains.d is in the correct state
2017-12-03 22:24:30,731 [salt.state       ][INFO    ][20938] Completed state [/etc/salt/grains.d] at time 22:24:30.730890 duration_in_ms=1.033
2017-12-03 22:24:30,731 [salt.state       ][INFO    ][20938] Running state [/etc/salt/grains] at time 22:24:30.731453
2017-12-03 22:24:30,732 [salt.state       ][INFO    ][20938] Executing state file.managed for /etc/salt/grains
2017-12-03 22:24:30,732 [salt.state       ][INFO    ][20938] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-03 22:24:30,732 [salt.state       ][INFO    ][20938] Completed state [/etc/salt/grains] at time 22:24:30.732202 duration_in_ms=0.749
2017-12-03 22:24:30,733 [salt.state       ][INFO    ][20938] Running state [/etc/salt/grains.d/placeholder] at time 22:24:30.732561
2017-12-03 22:24:30,733 [salt.state       ][INFO    ][20938] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-03 22:24:30,733 [salt.state       ][INFO    ][20938] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-03 22:24:30,733 [salt.state       ][INFO    ][20938] Completed state [/etc/salt/grains.d/placeholder] at time 22:24:30.733344 duration_in_ms=0.783
2017-12-03 22:24:30,734 [salt.state       ][INFO    ][20938] Running state [/etc/salt/grains.d/sphinx] at time 22:24:30.733732
2017-12-03 22:24:30,734 [salt.state       ][INFO    ][20938] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-03 22:24:30,735 [salt.state       ][INFO    ][20938] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.142
               - 192.168.11.252
-              - 192.168.122.1
         system:
           name: System
           param:

2017-12-03 22:24:30,736 [salt.state       ][INFO    ][20938] Completed state [/etc/salt/grains.d/sphinx] at time 22:24:30.735490 duration_in_ms=1.759
2017-12-03 22:24:30,736 [salt.state       ][INFO    ][20938] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.736227
2017-12-03 22:24:30,736 [salt.state       ][INFO    ][20938] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:24:30,737 [salt.state       ][INFO    ][20938] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:24:30,737 [salt.state       ][INFO    ][20938] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.736825 duration_in_ms=0.598
2017-12-03 22:24:30,737 [salt.state       ][INFO    ][20938] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.736990
2017-12-03 22:24:30,737 [salt.state       ][INFO    ][20938] 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-03 22:24:30,738 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-12-03 22:24:30,813 [salt.state       ][INFO    ][20938] {'pid': 20997, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-03 22:24:30,813 [salt.state       ][INFO    ][20938] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.813213 duration_in_ms=76.222
2017-12-03 22:24:30,814 [salt.state       ][INFO    ][20938] Running state [/etc/salt/grains.d/dns_records] at time 22:24:30.813708
2017-12-03 22:24:30,814 [salt.state       ][INFO    ][20938] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-03 22:24:30,815 [salt.state       ][INFO    ][20938] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-03 22:24:30,815 [salt.state       ][INFO    ][20938] Completed state [/etc/salt/grains.d/dns_records] at time 22:24:30.815024 duration_in_ms=1.315
2017-12-03 22:24:30,816 [salt.state       ][INFO    ][20938] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.815802
2017-12-03 22:24:30,816 [salt.state       ][INFO    ][20938] 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-03 22:24:30,816 [salt.state       ][INFO    ][20938] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:24:30,816 [salt.state       ][INFO    ][20938] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.816360 duration_in_ms=0.558
2017-12-03 22:24:30,817 [salt.state       ][INFO    ][20938] Running state [/etc/salt/grains.d/salt] at time 22:24:30.816711
2017-12-03 22:24:30,817 [salt.state       ][INFO    ][20938] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-03 22:24:30,818 [salt.state       ][INFO    ][20938] File /etc/salt/grains.d/salt is in the correct state
2017-12-03 22:24:30,818 [salt.state       ][INFO    ][20938] Completed state [/etc/salt/grains.d/salt] at time 22:24:30.817857 duration_in_ms=1.146
2017-12-03 22:24:30,819 [salt.state       ][INFO    ][20938] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.818544
2017-12-03 22:24:30,819 [salt.state       ][INFO    ][20938] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:24:30,819 [salt.state       ][INFO    ][20938] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:24:30,819 [salt.state       ][INFO    ][20938] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.819096 duration_in_ms=0.552
2017-12-03 22:24:30,821 [salt.state       ][INFO    ][20938] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:24:30.820634
2017-12-03 22:24:30,821 [salt.state       ][INFO    ][20938] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 22:24:30,821 [salt.state       ][INFO    ][20938] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 22:24:30,821 [salt.state       ][INFO    ][20938] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:24:30.821238 duration_in_ms=0.604
2017-12-03 22:24:30,821 [salt.state       ][INFO    ][20938] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:24:30.821393
2017-12-03 22:24:30,822 [salt.state       ][INFO    ][20938] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 22:24:30,823 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-12-03 22:24:30,830 [salt.state       ][INFO    ][20938] {'pid': 20999, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-03 22:24:30,830 [salt.state       ][INFO    ][20938] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:24:30.830069 duration_in_ms=8.676
2017-12-03 22:24:30,831 [salt.state       ][INFO    ][20938] Running state [mine.update] at time 22:24:30.830790
2017-12-03 22:24:30,831 [salt.state       ][INFO    ][20938] Executing state module.wait for mine.update
2017-12-03 22:24:30,831 [salt.state       ][INFO    ][20938] No changes made for mine.update
2017-12-03 22:24:30,831 [salt.state       ][INFO    ][20938] Completed state [mine.update] at time 22:24:30.831391 duration_in_ms=0.601
2017-12-03 22:24:30,832 [salt.state       ][INFO    ][20938] Running state [mine.update] at time 22:24:30.831545
2017-12-03 22:24:30,832 [salt.state       ][INFO    ][20938] Executing state module.mod_watch for mine.update
2017-12-03 22:24:31,348 [salt.state       ][INFO    ][20938] {'ret': True}
2017-12-03 22:24:31,348 [salt.state       ][INFO    ][20938] Completed state [mine.update] at time 22:24:31.347699 duration_in_ms=516.155
2017-12-03 22:24:31,348 [salt.state       ][INFO    ][20938] Running state [ca-certificates] at time 22:24:31.347952
2017-12-03 22:24:31,348 [salt.state       ][INFO    ][20938] Executing state pkg.installed for ca-certificates
2017-12-03 22:24:31,352 [salt.state       ][INFO    ][20938] Package ca-certificates is already installed
2017-12-03 22:24:31,352 [salt.state       ][INFO    ][20938] Completed state [ca-certificates] at time 22:24:31.352227 duration_in_ms=4.275
2017-12-03 22:24:31,353 [salt.state       ][INFO    ][20938] Running state [update-ca-certificates] at time 22:24:31.352848
2017-12-03 22:24:31,353 [salt.state       ][INFO    ][20938] Executing state cmd.wait for update-ca-certificates
2017-12-03 22:24:31,353 [salt.state       ][INFO    ][20938] No changes made for update-ca-certificates
2017-12-03 22:24:31,353 [salt.state       ][INFO    ][20938] Completed state [update-ca-certificates] at time 22:24:31.353417 duration_in_ms=0.569
2017-12-03 22:24:31,354 [salt.state       ][INFO    ][20938] Running state [libvirt-dev] at time 22:24:31.353589
2017-12-03 22:24:31,354 [salt.state       ][INFO    ][20938] Executing state pkg.installed for libvirt-dev
2017-12-03 22:24:31,357 [salt.state       ][INFO    ][20938] Package libvirt-dev is already installed
2017-12-03 22:24:31,358 [salt.state       ][INFO    ][20938] Completed state [libvirt-dev] at time 22:24:31.357530 duration_in_ms=3.941
2017-12-03 22:24:31,358 [salt.state       ][INFO    ][20938] Running state [pkg-config] at time 22:24:31.357717
2017-12-03 22:24:31,358 [salt.state       ][INFO    ][20938] Executing state pkg.installed for pkg-config
2017-12-03 22:24:31,362 [salt.state       ][INFO    ][20938] Package pkg-config is already installed
2017-12-03 22:24:31,362 [salt.state       ][INFO    ][20938] Completed state [pkg-config] at time 22:24:31.361652 duration_in_ms=3.934
2017-12-03 22:24:31,362 [salt.state       ][INFO    ][20938] Running state [virtng.init] at time 22:24:31.361844
2017-12-03 22:24:31,362 [salt.state       ][INFO    ][20938] Executing state module.run for virtng.init
2017-12-03 22:24:31,455 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command ['git', '--version'] in directory '/root'
2017-12-03 22:24:31,504 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,520 [salt.state       ][INFO    ][20938] unless execution succeeded
2017-12-03 22:24:31,520 [salt.state       ][INFO    ][20938] Completed state [virtng.init] at time 22:24:31.520350 duration_in_ms=158.505
2017-12-03 22:24:31,521 [salt.state       ][INFO    ][20938] Running state [virt.set_autostart] at time 22:24:31.520609
2017-12-03 22:24:31,521 [salt.state       ][INFO    ][20938] Executing state module.run for virt.set_autostart
2017-12-03 22:24:31,523 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,540 [salt.state       ][INFO    ][20938] unless execution succeeded
2017-12-03 22:24:31,540 [salt.state       ][INFO    ][20938] Completed state [virt.set_autostart] at time 22:24:31.539913 duration_in_ms=19.303
2017-12-03 22:24:31,540 [salt.state       ][INFO    ][20938] Running state [virtng.init] at time 22:24:31.540156
2017-12-03 22:24:31,540 [salt.state       ][INFO    ][20938] Executing state module.run for virtng.init
2017-12-03 22:24:31,543 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,557 [salt.state       ][INFO    ][20938] unless execution succeeded
2017-12-03 22:24:31,557 [salt.state       ][INFO    ][20938] Completed state [virtng.init] at time 22:24:31.557383 duration_in_ms=17.226
2017-12-03 22:24:31,558 [salt.state       ][INFO    ][20938] Running state [virt.set_autostart] at time 22:24:31.557645
2017-12-03 22:24:31,558 [salt.state       ][INFO    ][20938] Executing state module.run for virt.set_autostart
2017-12-03 22:24:31,560 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,575 [salt.state       ][INFO    ][20938] unless execution succeeded
2017-12-03 22:24:31,576 [salt.state       ][INFO    ][20938] Completed state [virt.set_autostart] at time 22:24:31.575475 duration_in_ms=17.829
2017-12-03 22:24:31,576 [salt.state       ][INFO    ][20938] Running state [virtng.init] at time 22:24:31.575717
2017-12-03 22:24:31,576 [salt.state       ][INFO    ][20938] Executing state module.run for virtng.init
2017-12-03 22:24:31,579 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,593 [salt.state       ][INFO    ][20938] unless execution succeeded
2017-12-03 22:24:31,593 [salt.state       ][INFO    ][20938] Completed state [virtng.init] at time 22:24:31.592815 duration_in_ms=17.097
2017-12-03 22:24:31,593 [salt.state       ][INFO    ][20938] Running state [virt.set_autostart] at time 22:24:31.593162
2017-12-03 22:24:31,593 [salt.state       ][INFO    ][20938] Executing state module.run for virt.set_autostart
2017-12-03 22:24:31,596 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,611 [salt.state       ][INFO    ][20938] unless execution succeeded
2017-12-03 22:24:31,611 [salt.state       ][INFO    ][20938] Completed state [virt.set_autostart] at time 22:24:31.610801 duration_in_ms=17.639
2017-12-03 22:24:31,611 [salt.state       ][INFO    ][20938] Running state [virtng.init] at time 22:24:31.611031
2017-12-03 22:24:31,611 [salt.state       ][INFO    ][20938] Executing state module.run for virtng.init
2017-12-03 22:24:31,614 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,627 [salt.state       ][INFO    ][20938] unless execution succeeded
2017-12-03 22:24:31,627 [salt.state       ][INFO    ][20938] Completed state [virtng.init] at time 22:24:31.627129 duration_in_ms=16.098
2017-12-03 22:24:31,627 [salt.state       ][INFO    ][20938] Running state [virt.set_autostart] at time 22:24:31.627351
2017-12-03 22:24:31,628 [salt.state       ][INFO    ][20938] Executing state module.run for virt.set_autostart
2017-12-03 22:24:31,630 [salt.loaded.int.module.cmdmod][INFO    ][20938] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,644 [salt.state       ][INFO    ][20938] unless execution succeeded
2017-12-03 22:24:31,644 [salt.state       ][INFO    ][20938] Completed state [virt.set_autostart] at time 22:24:31.644016 duration_in_ms=16.664
2017-12-03 22:24:31,647 [salt.minion      ][INFO    ][20938] Returning information for job: 20171203222426901310
2017-12-03 22:24:58,074 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command state.sls with jid 20171203222458060640
2017-12-03 22:24:58,085 [salt.minion      ][INFO    ][21049] Starting a new job with PID 21049
2017-12-03 22:25:00,678 [salt.state       ][INFO    ][21049] Loading fresh modules for state activity
2017-12-03 22:25:00,709 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-03 22:25:00,729 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-03 22:25:00,790 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:25:00,869 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-03 22:25:00,883 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-03 22:25:00,912 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:25:00,980 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-03 22:25:00,1000 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 22:25:01,056 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-03 22:25:01,076 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-03 22:25:01,091 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 22:25:01,109 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-03 22:25:01,118 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-03 22:25:01,141 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-03 22:25:01,159 [py.warnings      ][WARNING ][21049] /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-03 22:25:01,160 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command 'salt-minion --version' in directory '/root'
2017-12-03 22:25:01,416 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-03 22:25:01,439 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-03 22:25:01,455 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-03 22:25:01,469 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-03 22:25:01,512 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-03 22:25:01,527 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-03 22:25:01,555 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-03 22:25:01,571 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-03 22:25:01,591 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-03 22:25:01,629 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-03 22:25:01,697 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-03 22:25:01,720 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:25:01,788 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-03 22:25:01,810 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 22:25:01,868 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-03 22:25:01,891 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-03 22:25:01,906 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 22:25:01,925 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-03 22:25:01,933 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-03 22:25:01,957 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-03 22:25:01,975 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command 'salt-minion --version' in directory '/root'
2017-12-03 22:25:02,231 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-03 22:25:02,251 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-03 22:25:02,267 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-03 22:25:02,280 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-03 22:25:02,322 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-03 22:25:02,336 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-03 22:25:02,356 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-03 22:25:02,371 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-03 22:25:02,389 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-03 22:25:02,430 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-03 22:25:02,507 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-03 22:25:02,591 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:25:02,922 [salt.state       ][INFO    ][21049] Running state [salt-minion] at time 22:25:02.922046
2017-12-03 22:25:02,922 [salt.state       ][INFO    ][21049] Executing state pkg.installed for salt-minion
2017-12-03 22:25:02,923 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:25:03,181 [salt.state       ][INFO    ][21049] Package salt-minion is already installed
2017-12-03 22:25:03,181 [salt.state       ][INFO    ][21049] Completed state [salt-minion] at time 22:25:03.181237 duration_in_ms=259.191
2017-12-03 22:25:03,182 [salt.state       ][INFO    ][21049] Running state [salt_minion_dependency_packages] at time 22:25:03.181526
2017-12-03 22:25:03,182 [salt.state       ][INFO    ][21049] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-03 22:25:03,185 [salt.state       ][INFO    ][21049] All specified packages are already installed
2017-12-03 22:25:03,186 [salt.state       ][INFO    ][21049] Completed state [salt_minion_dependency_packages] at time 22:25:03.185621 duration_in_ms=4.094
2017-12-03 22:25:03,187 [salt.state       ][INFO    ][21049] Running state [/etc/salt/minion.d/minion.conf] at time 22:25:03.187266
2017-12-03 22:25:03,188 [salt.state       ][INFO    ][21049] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-03 22:25:03,212 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-03 22:25:03,270 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:25:03,324 [salt.fileclient  ][INFO    ][21049] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 22:25:03,371 [salt.state       ][INFO    ][21049] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-03 22:25:03,371 [salt.state       ][INFO    ][21049] Completed state [/etc/salt/minion.d/minion.conf] at time 22:25:03.370880 duration_in_ms=183.613
2017-12-03 22:25:03,371 [salt.state       ][INFO    ][21049] Running state [/etc/salt/minion.d/_virt.conf] at time 22:25:03.371247
2017-12-03 22:25:03,371 [salt.state       ][INFO    ][21049] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-03 22:25:03,372 [salt.state       ][INFO    ][21049] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-03 22:25:03,372 [salt.state       ][INFO    ][21049] Completed state [/etc/salt/minion.d/_virt.conf] at time 22:25:03.372255 duration_in_ms=1.008
2017-12-03 22:25:03,374 [salt.state       ][INFO    ][21049] Running state [salt-minion] at time 22:25:03.373869
2017-12-03 22:25:03,374 [salt.state       ][INFO    ][21049] Executing state service.running for salt-minion
2017-12-03 22:25:03,375 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-03 22:25:03,390 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-03 22:25:03,397 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-03 22:25:03,405 [salt.state       ][INFO    ][21049] The service salt-minion is already running
2017-12-03 22:25:03,405 [salt.state       ][INFO    ][21049] Completed state [salt-minion] at time 22:25:03.405315 duration_in_ms=31.433
2017-12-03 22:25:03,407 [salt.state       ][INFO    ][21049] Running state [/etc/salt/grains.d] at time 22:25:03.406737
2017-12-03 22:25:03,407 [salt.state       ][INFO    ][21049] Executing state file.directory for /etc/salt/grains.d
2017-12-03 22:25:03,408 [salt.state       ][INFO    ][21049] Directory /etc/salt/grains.d is in the correct state
2017-12-03 22:25:03,408 [salt.state       ][INFO    ][21049] Completed state [/etc/salt/grains.d] at time 22:25:03.407736 duration_in_ms=0.999
2017-12-03 22:25:03,408 [salt.state       ][INFO    ][21049] Running state [/etc/salt/grains] at time 22:25:03.408283
2017-12-03 22:25:03,409 [salt.state       ][INFO    ][21049] Executing state file.managed for /etc/salt/grains
2017-12-03 22:25:03,409 [salt.state       ][INFO    ][21049] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-03 22:25:03,409 [salt.state       ][INFO    ][21049] Completed state [/etc/salt/grains] at time 22:25:03.409059 duration_in_ms=0.776
2017-12-03 22:25:03,409 [salt.state       ][INFO    ][21049] Running state [/etc/salt/grains.d/placeholder] at time 22:25:03.409418
2017-12-03 22:25:03,410 [salt.state       ][INFO    ][21049] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-03 22:25:03,410 [salt.state       ][INFO    ][21049] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-03 22:25:03,410 [salt.state       ][INFO    ][21049] Completed state [/etc/salt/grains.d/placeholder] at time 22:25:03.410136 duration_in_ms=0.718
2017-12-03 22:25:03,411 [salt.state       ][INFO    ][21049] Running state [/etc/salt/grains.d/sphinx] at time 22:25:03.410482
2017-12-03 22:25:03,411 [salt.state       ][INFO    ][21049] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-03 22:25:03,411 [salt.state       ][INFO    ][21049] File /etc/salt/grains.d/sphinx is in the correct state
2017-12-03 22:25:03,412 [salt.state       ][INFO    ][21049] Completed state [/etc/salt/grains.d/sphinx] at time 22:25:03.411545 duration_in_ms=1.063
2017-12-03 22:25:03,412 [salt.state       ][INFO    ][21049] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:25:03.412262
2017-12-03 22:25:03,412 [salt.state       ][INFO    ][21049] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:25:03,413 [salt.state       ][INFO    ][21049] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:25:03,413 [salt.state       ][INFO    ][21049] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:25:03.412872 duration_in_ms=0.61
2017-12-03 22:25:03,413 [salt.state       ][INFO    ][21049] Running state [/etc/salt/grains.d/dns_records] at time 22:25:03.413242
2017-12-03 22:25:03,413 [salt.state       ][INFO    ][21049] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-03 22:25:03,414 [salt.state       ][INFO    ][21049] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-03 22:25:03,414 [salt.state       ][INFO    ][21049] Completed state [/etc/salt/grains.d/dns_records] at time 22:25:03.414222 duration_in_ms=0.98
2017-12-03 22:25:03,415 [salt.state       ][INFO    ][21049] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:25:03.414951
2017-12-03 22:25:03,415 [salt.state       ][INFO    ][21049] 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-03 22:25:03,415 [salt.state       ][INFO    ][21049] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:25:03,416 [salt.state       ][INFO    ][21049] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:25:03.415522 duration_in_ms=0.571
2017-12-03 22:25:03,416 [salt.state       ][INFO    ][21049] Running state [/etc/salt/grains.d/salt] at time 22:25:03.415866
2017-12-03 22:25:03,416 [salt.state       ][INFO    ][21049] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-03 22:25:03,417 [salt.state       ][INFO    ][21049] File /etc/salt/grains.d/salt is in the correct state
2017-12-03 22:25:03,417 [salt.state       ][INFO    ][21049] Completed state [/etc/salt/grains.d/salt] at time 22:25:03.416883 duration_in_ms=1.016
2017-12-03 22:25:03,418 [salt.state       ][INFO    ][21049] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:25:03.417628
2017-12-03 22:25:03,418 [salt.state       ][INFO    ][21049] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:25:03,418 [salt.state       ][INFO    ][21049] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:25:03,418 [salt.state       ][INFO    ][21049] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:25:03.418202 duration_in_ms=0.573
2017-12-03 22:25:03,420 [salt.state       ][INFO    ][21049] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:25:03.419705
2017-12-03 22:25:03,420 [salt.state       ][INFO    ][21049] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 22:25:03,420 [salt.state       ][INFO    ][21049] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 22:25:03,420 [salt.state       ][INFO    ][21049] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:25:03.420290 duration_in_ms=0.585
2017-12-03 22:25:03,421 [salt.state       ][INFO    ][21049] Running state [mine.update] at time 22:25:03.420824
2017-12-03 22:25:03,421 [salt.state       ][INFO    ][21049] Executing state module.wait for mine.update
2017-12-03 22:25:03,421 [salt.state       ][INFO    ][21049] No changes made for mine.update
2017-12-03 22:25:03,421 [salt.state       ][INFO    ][21049] Completed state [mine.update] at time 22:25:03.421379 duration_in_ms=0.555
2017-12-03 22:25:03,422 [salt.state       ][INFO    ][21049] Running state [ca-certificates] at time 22:25:03.421548
2017-12-03 22:25:03,422 [salt.state       ][INFO    ][21049] Executing state pkg.installed for ca-certificates
2017-12-03 22:25:03,426 [salt.state       ][INFO    ][21049] Package ca-certificates is already installed
2017-12-03 22:25:03,426 [salt.state       ][INFO    ][21049] Completed state [ca-certificates] at time 22:25:03.425854 duration_in_ms=4.305
2017-12-03 22:25:03,426 [salt.state       ][INFO    ][21049] Running state [update-ca-certificates] at time 22:25:03.426404
2017-12-03 22:25:03,427 [salt.state       ][INFO    ][21049] Executing state cmd.wait for update-ca-certificates
2017-12-03 22:25:03,427 [salt.state       ][INFO    ][21049] No changes made for update-ca-certificates
2017-12-03 22:25:03,427 [salt.state       ][INFO    ][21049] Completed state [update-ca-certificates] at time 22:25:03.426952 duration_in_ms=0.548
2017-12-03 22:25:03,427 [salt.state       ][INFO    ][21049] Running state [libvirt-dev] at time 22:25:03.427123
2017-12-03 22:25:03,427 [salt.state       ][INFO    ][21049] Executing state pkg.installed for libvirt-dev
2017-12-03 22:25:03,431 [salt.state       ][INFO    ][21049] Package libvirt-dev is already installed
2017-12-03 22:25:03,431 [salt.state       ][INFO    ][21049] Completed state [libvirt-dev] at time 22:25:03.431065 duration_in_ms=3.942
2017-12-03 22:25:03,431 [salt.state       ][INFO    ][21049] Running state [pkg-config] at time 22:25:03.431254
2017-12-03 22:25:03,431 [salt.state       ][INFO    ][21049] Executing state pkg.installed for pkg-config
2017-12-03 22:25:03,435 [salt.state       ][INFO    ][21049] Package pkg-config is already installed
2017-12-03 22:25:03,435 [salt.state       ][INFO    ][21049] Completed state [pkg-config] at time 22:25:03.435238 duration_in_ms=3.983
2017-12-03 22:25:03,435 [salt.state       ][INFO    ][21049] Running state [virtng.init] at time 22:25:03.435415
2017-12-03 22:25:03,436 [salt.state       ][INFO    ][21049] Executing state module.run for virtng.init
2017-12-03 22:25:03,526 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command ['git', '--version'] in directory '/root'
2017-12-03 22:25:03,568 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,584 [salt.state       ][INFO    ][21049] unless execution succeeded
2017-12-03 22:25:03,584 [salt.state       ][INFO    ][21049] Completed state [virtng.init] at time 22:25:03.584365 duration_in_ms=148.95
2017-12-03 22:25:03,585 [salt.state       ][INFO    ][21049] Running state [virt.set_autostart] at time 22:25:03.584639
2017-12-03 22:25:03,585 [salt.state       ][INFO    ][21049] Executing state module.run for virt.set_autostart
2017-12-03 22:25:03,588 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,604 [salt.state       ][INFO    ][21049] unless execution succeeded
2017-12-03 22:25:03,604 [salt.state       ][INFO    ][21049] Completed state [virt.set_autostart] at time 22:25:03.604166 duration_in_ms=19.527
2017-12-03 22:25:03,604 [salt.state       ][INFO    ][21049] Running state [virtng.init] at time 22:25:03.604402
2017-12-03 22:25:03,605 [salt.state       ][INFO    ][21049] Executing state module.run for virtng.init
2017-12-03 22:25:03,607 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,622 [salt.state       ][INFO    ][21049] unless execution succeeded
2017-12-03 22:25:03,622 [salt.state       ][INFO    ][21049] Completed state [virtng.init] at time 22:25:03.621780 duration_in_ms=17.378
2017-12-03 22:25:03,622 [salt.state       ][INFO    ][21049] Running state [virt.set_autostart] at time 22:25:03.622025
2017-12-03 22:25:03,622 [salt.state       ][INFO    ][21049] Executing state module.run for virt.set_autostart
2017-12-03 22:25:03,625 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,640 [salt.state       ][INFO    ][21049] unless execution succeeded
2017-12-03 22:25:03,640 [salt.state       ][INFO    ][21049] Completed state [virt.set_autostart] at time 22:25:03.640215 duration_in_ms=18.19
2017-12-03 22:25:03,640 [salt.state       ][INFO    ][21049] Running state [virtng.init] at time 22:25:03.640459
2017-12-03 22:25:03,641 [salt.state       ][INFO    ][21049] Executing state module.run for virtng.init
2017-12-03 22:25:03,643 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,658 [salt.state       ][INFO    ][21049] unless execution succeeded
2017-12-03 22:25:03,658 [salt.state       ][INFO    ][21049] Completed state [virtng.init] at time 22:25:03.657779 duration_in_ms=17.32
2017-12-03 22:25:03,658 [salt.state       ][INFO    ][21049] Running state [virt.set_autostart] at time 22:25:03.658023
2017-12-03 22:25:03,658 [salt.state       ][INFO    ][21049] Executing state module.run for virt.set_autostart
2017-12-03 22:25:03,661 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,676 [salt.state       ][INFO    ][21049] unless execution succeeded
2017-12-03 22:25:03,676 [salt.state       ][INFO    ][21049] Completed state [virt.set_autostart] at time 22:25:03.675914 duration_in_ms=17.891
2017-12-03 22:25:03,676 [salt.state       ][INFO    ][21049] Running state [virtng.init] at time 22:25:03.676172
2017-12-03 22:25:03,676 [salt.state       ][INFO    ][21049] Executing state module.run for virtng.init
2017-12-03 22:25:03,679 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,693 [salt.state       ][INFO    ][21049] unless execution succeeded
2017-12-03 22:25:03,693 [salt.state       ][INFO    ][21049] Completed state [virtng.init] at time 22:25:03.693224 duration_in_ms=17.052
2017-12-03 22:25:03,694 [salt.state       ][INFO    ][21049] Running state [virt.set_autostart] at time 22:25:03.693496
2017-12-03 22:25:03,694 [salt.state       ][INFO    ][21049] Executing state module.run for virt.set_autostart
2017-12-03 22:25:03,696 [salt.loaded.int.module.cmdmod][INFO    ][21049] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,711 [salt.state       ][INFO    ][21049] unless execution succeeded
2017-12-03 22:25:03,711 [salt.state       ][INFO    ][21049] Completed state [virt.set_autostart] at time 22:25:03.710904 duration_in_ms=17.407
2017-12-03 22:25:03,714 [salt.minion      ][INFO    ][21049] Returning information for job: 20171203222458060640
2017-12-03 22:25:23,555 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171203222523545684
2017-12-03 22:25:23,570 [salt.minion      ][INFO    ][21139] Starting a new job with PID 21139
2017-12-03 22:25:28,024 [salt.state       ][INFO    ][21139] Loading fresh modules for state activity
2017-12-03 22:25:28,053 [salt.state       ][ERROR   ][21139] No contents found in top file
2017-12-03 22:25:28,054 [salt.utils.extmods][INFO    ][21139] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-03 22:25:28,057 [salt.utils.extmods][INFO    ][21139] Syncing beacons for environment 'base'
2017-12-03 22:25:28,057 [salt.utils.extmods][INFO    ][21139] Loading cache from salt://_beacons, for base)
2017-12-03 22:25:28,057 [salt.fileclient  ][INFO    ][21139] Caching directory '_beacons/' for environment 'base'
2017-12-03 22:25:28,096 [salt.utils.extmods][INFO    ][21139] Syncing modules for environment 'base'
2017-12-03 22:25:28,096 [salt.utils.extmods][INFO    ][21139] Loading cache from salt://_modules, for base)
2017-12-03 22:25:28,096 [salt.fileclient  ][INFO    ][21139] Caching directory '_modules/' for environment 'base'
2017-12-03 22:25:28,145 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-03 22:25:28,156 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-03 22:25:28,168 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-03 22:25:28,180 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-03 22:25:28,188 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-03 22:25:28,196 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-03 22:25:28,205 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-03 22:25:28,217 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-03 22:25:28,238 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-03 22:25:28,247 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-03 22:25:28,256 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-03 22:25:28,266 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-03 22:25:28,275 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-03 22:25:28,284 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-03 22:25:28,293 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-03 22:25:28,649 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-03 22:25:28,666 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-03 22:25:28,688 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-03 22:25:28,709 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-03 22:25:28,743 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-03 22:25:28,763 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-03 22:25:28,777 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-03 22:25:28,795 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-03 22:25:28,814 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-03 22:25:28,823 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-03 22:25:28,835 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-03 22:25:28,859 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-03 22:25:28,875 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-03 22:25:28,886 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-03 22:25:28,917 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-03 22:25:28,929 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-03 22:25:28,939 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-03 22:25:28,955 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-03 22:25:28,971 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-03 22:25:28,976 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-03 22:25:28,976 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-03 22:25:28,976 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-03 22:25:28,977 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-03 22:25:28,977 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-03 22:25:28,977 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-03 22:25:28,978 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-03 22:25:28,978 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-03 22:25:28,978 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-03 22:25:28,978 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-03 22:25:28,979 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-03 22:25:28,979 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-03 22:25:28,979 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-03 22:25:28,979 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-03 22:25:28,980 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-03 22:25:28,980 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-03 22:25:28,980 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-03 22:25:28,980 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-03 22:25:28,981 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-03 22:25:28,981 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-03 22:25:28,981 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-03 22:25:28,982 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-03 22:25:28,982 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-03 22:25:28,982 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-03 22:25:28,983 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-03 22:25:28,983 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-03 22:25:28,983 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-03 22:25:28,983 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-03 22:25:28,984 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-03 22:25:28,984 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-03 22:25:28,984 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-03 22:25:28,984 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-03 22:25:28,985 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-03 22:25:28,985 [salt.utils.extmods][INFO    ][21139] 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-03 22:25:28,985 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-03 22:25:28,985 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-03 22:25:28,991 [salt.utils.extmods][INFO    ][21139] Syncing states for environment 'base'
2017-12-03 22:25:28,992 [salt.utils.extmods][INFO    ][21139] Loading cache from salt://_states, for base)
2017-12-03 22:25:28,992 [salt.fileclient  ][INFO    ][21139] Caching directory '_states/' for environment 'base'
2017-12-03 22:25:29,076 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-03 22:25:29,088 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-03 22:25:29,111 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-03 22:25:29,126 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-03 22:25:29,136 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-03 22:25:29,152 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-03 22:25:29,178 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-03 22:25:29,196 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-03 22:25:29,212 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-03 22:25:29,226 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-03 22:25:29,242 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-03 22:25:29,258 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-03 22:25:29,274 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-03 22:25:29,288 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-03 22:25:29,321 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-03 22:25:29,333 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-03 22:25:29,347 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-03 22:25:29,365 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-03 22:25:29,375 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-03 22:25:29,420 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-03 22:25:29,434 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-03 22:25:29,448 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-03 22:25:29,464 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-03 22:25:29,480 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-03 22:25:29,494 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-03 22:25:29,510 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-03 22:25:29,536 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-03 22:25:29,551 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-03 22:25:29,564 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-03 22:25:29,586 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-03 22:25:29,649 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-03 22:25:29,668 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-03 22:25:29,672 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-03 22:25:29,673 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-03 22:25:29,673 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-03 22:25:29,674 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-03 22:25:29,674 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-03 22:25:29,674 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-03 22:25:29,675 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-03 22:25:29,675 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-03 22:25:29,675 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-03 22:25:29,676 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-03 22:25:29,676 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-03 22:25:29,676 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-03 22:25:29,676 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-03 22:25:29,677 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-03 22:25:29,677 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-03 22:25:29,677 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-03 22:25:29,677 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-03 22:25:29,678 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-03 22:25:29,678 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-03 22:25:29,678 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-03 22:25:29,678 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-03 22:25:29,679 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-03 22:25:29,679 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-03 22:25:29,680 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-03 22:25:29,680 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-03 22:25:29,681 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-03 22:25:29,681 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-03 22:25:29,681 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-03 22:25:29,681 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-03 22:25:29,682 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-03 22:25:29,682 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-03 22:25:29,682 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-03 22:25:29,682 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-03 22:25:29,685 [salt.utils.extmods][INFO    ][21139] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-03 22:25:29,688 [salt.utils.extmods][INFO    ][21139] Syncing sdb for environment 'base'
2017-12-03 22:25:29,689 [salt.utils.extmods][INFO    ][21139] Loading cache from salt://_sdb, for base)
2017-12-03 22:25:29,689 [salt.fileclient  ][INFO    ][21139] Caching directory '_sdb/' for environment 'base'
2017-12-03 22:25:29,748 [salt.utils.extmods][INFO    ][21139] Syncing grains for environment 'base'
2017-12-03 22:25:29,748 [salt.utils.extmods][INFO    ][21139] Loading cache from salt://_grains, for base)
2017-12-03 22:25:29,748 [salt.fileclient  ][INFO    ][21139] Caching directory '_grains/' for environment 'base'
2017-12-03 22:25:29,819 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-03 22:25:29,833 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-03 22:25:29,844 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-03 22:25:29,867 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-03 22:25:29,877 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-03 22:25:29,891 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-03 22:25:29,905 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-03 22:25:29,921 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-03 22:25:29,937 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-03 22:25:29,956 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-03 22:25:29,967 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-03 22:25:29,995 [salt.fileclient  ][INFO    ][21139] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-03 22:25:29,999 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-03 22:25:29,999 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-03 22:25:29,1000 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-03 22:25:29,1000 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-03 22:25:29,1000 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-03 22:25:30,000 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-03 22:25:30,000 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-03 22:25:30,001 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-03 22:25:30,001 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-03 22:25:30,001 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-03 22:25:30,001 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-03 22:25:30,002 [salt.utils.extmods][INFO    ][21139] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-03 22:25:30,003 [salt.utils.extmods][INFO    ][21139] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-03 22:25:30,006 [salt.utils.extmods][INFO    ][21139] Syncing renderers for environment 'base'
2017-12-03 22:25:30,007 [salt.utils.extmods][INFO    ][21139] Loading cache from salt://_renderers, for base)
2017-12-03 22:25:30,007 [salt.fileclient  ][INFO    ][21139] Caching directory '_renderers/' for environment 'base'
2017-12-03 22:25:30,052 [salt.utils.extmods][INFO    ][21139] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-03 22:25:30,055 [salt.utils.extmods][INFO    ][21139] Syncing returners for environment 'base'
2017-12-03 22:25:30,055 [salt.utils.extmods][INFO    ][21139] Loading cache from salt://_returners, for base)
2017-12-03 22:25:30,055 [salt.fileclient  ][INFO    ][21139] Caching directory '_returners/' for environment 'base'
2017-12-03 22:25:30,126 [salt.utils.extmods][INFO    ][21139] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-03 22:25:30,129 [salt.utils.extmods][INFO    ][21139] Syncing output for environment 'base'
2017-12-03 22:25:30,129 [salt.utils.extmods][INFO    ][21139] Loading cache from salt://_output, for base)
2017-12-03 22:25:30,129 [salt.fileclient  ][INFO    ][21139] Caching directory '_output/' for environment 'base'
2017-12-03 22:25:30,186 [salt.utils.extmods][INFO    ][21139] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-03 22:25:30,190 [salt.utils.extmods][INFO    ][21139] Syncing utils for environment 'base'
2017-12-03 22:25:30,190 [salt.utils.extmods][INFO    ][21139] Loading cache from salt://_utils, for base)
2017-12-03 22:25:30,190 [salt.fileclient  ][INFO    ][21139] Caching directory '_utils/' for environment 'base'
2017-12-03 22:25:30,281 [salt.utils.extmods][INFO    ][21139] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-03 22:25:30,284 [salt.utils.extmods][INFO    ][21139] Syncing log_handlers for environment 'base'
2017-12-03 22:25:30,284 [salt.utils.extmods][INFO    ][21139] Loading cache from salt://_log_handlers, for base)
2017-12-03 22:25:30,284 [salt.fileclient  ][INFO    ][21139] Caching directory '_log_handlers/' for environment 'base'
2017-12-03 22:25:30,350 [salt.utils.extmods][INFO    ][21139] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-03 22:25:30,353 [salt.utils.extmods][INFO    ][21139] Syncing proxy for environment 'base'
2017-12-03 22:25:30,354 [salt.utils.extmods][INFO    ][21139] Loading cache from salt://_proxy, for base)
2017-12-03 22:25:30,354 [salt.fileclient  ][INFO    ][21139] Caching directory '_proxy/' for environment 'base'
2017-12-03 22:25:30,418 [salt.utils.extmods][INFO    ][21139] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-03 22:25:30,422 [salt.utils.extmods][INFO    ][21139] Syncing engines for environment 'base'
2017-12-03 22:25:30,422 [salt.utils.extmods][INFO    ][21139] Loading cache from salt://_engines, for base)
2017-12-03 22:25:30,422 [salt.fileclient  ][INFO    ][21139] Caching directory '_engines/' for environment 'base'
2017-12-03 22:25:30,467 [salt.minion      ][INFO    ][21139] Returning information for job: 20171203222523545684
2017-12-03 22:33:00,492 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command test.ping with jid 20171203223300483255
2017-12-03 22:33:00,509 [salt.minion      ][INFO    ][21293] Starting a new job with PID 21293
2017-12-03 22:33:00,548 [salt.minion      ][INFO    ][21293] Returning information for job: 20171203223300483255
2017-12-03 22:34:30,433 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command state.sls with jid 20171203223430425069
2017-12-03 22:34:30,445 [salt.minion      ][INFO    ][21315] Starting a new job with PID 21315
2017-12-03 22:34:31,055 [salt.state       ][INFO    ][21315] Loading fresh modules for state activity
2017-12-03 22:34:31,087 [salt.fileclient  ][INFO    ][21315] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-03 22:34:31,104 [salt.fileclient  ][INFO    ][21315] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-03 22:34:31,131 [salt.fileclient  ][INFO    ][21315] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 22:34:31,463 [salt.state       ][INFO    ][21315] Running state [lsof] at time 22:34:31.463054
2017-12-03 22:34:31,463 [salt.state       ][INFO    ][21315] Executing state pkg.installed for lsof
2017-12-03 22:34:31,464 [salt.loaded.int.module.cmdmod][INFO    ][21315] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:34:31,732 [salt.state       ][INFO    ][21315] Package lsof is already installed
2017-12-03 22:34:31,733 [salt.state       ][INFO    ][21315] Completed state [lsof] at time 22:34:31.732637 duration_in_ms=269.584
2017-12-03 22:34:31,733 [salt.state       ][INFO    ][21315] Running state [keepalived] at time 22:34:31.732877
2017-12-03 22:34:31,733 [salt.state       ][INFO    ][21315] Executing state pkg.installed for keepalived
2017-12-03 22:34:31,750 [salt.loaded.int.module.cmdmod][INFO    ][21315] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-03 22:34:33,037 [salt.loaded.int.module.cmdmod][INFO    ][21315] 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-03 22:34:35,630 [salt.loaded.int.module.cmdmod][INFO    ][21315] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:34:35,656 [salt.state       ][INFO    ][21315] 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-03 22:34:35,667 [salt.state       ][INFO    ][21315] Loading fresh modules for state activity
2017-12-03 22:34:35,682 [salt.state       ][INFO    ][21315] Completed state [keepalived] at time 22:34:35.682376 duration_in_ms=3949.498
2017-12-03 22:34:35,684 [salt.state       ][INFO    ][21315] Running state [/etc/keepalived/keepalived.conf] at time 22:34:35.684320
2017-12-03 22:34:35,685 [salt.state       ][INFO    ][21315] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-03 22:34:35,713 [salt.fileclient  ][INFO    ][21315] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-03 22:34:35,754 [salt.fileclient  ][INFO    ][21315] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 22:34:35,762 [salt.state       ][INFO    ][21315] File changed:
New file
2017-12-03 22:34:35,762 [salt.state       ][INFO    ][21315] Completed state [/etc/keepalived/keepalived.conf] at time 22:34:35.761967 duration_in_ms=77.647
2017-12-03 22:34:35,826 [salt.state       ][INFO    ][21315] Running state [keepalived] at time 22:34:35.826440
2017-12-03 22:34:35,827 [salt.state       ][INFO    ][21315] Executing state service.running for keepalived
2017-12-03 22:34:35,828 [salt.loaded.int.module.cmdmod][INFO    ][21315] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-03 22:34:35,838 [salt.loaded.int.module.cmdmod][INFO    ][21315] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:35,845 [salt.loaded.int.module.cmdmod][INFO    ][21315] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:35,852 [salt.loaded.int.module.cmdmod][INFO    ][21315] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:35,859 [salt.loaded.int.module.cmdmod][INFO    ][21315] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:35,890 [salt.loaded.int.module.cmdmod][INFO    ][21315] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:35,898 [salt.loaded.int.module.cmdmod][INFO    ][21315] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:35,905 [salt.loaded.int.module.cmdmod][INFO    ][21315] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:35,912 [salt.state       ][INFO    ][21315] {'keepalived': True}
2017-12-03 22:34:35,912 [salt.state       ][INFO    ][21315] Completed state [keepalived] at time 22:34:35.912429 duration_in_ms=85.989
2017-12-03 22:34:35,914 [salt.minion      ][INFO    ][21315] Returning information for job: 20171203223430425069
2017-12-03 22:34:56,467 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command pillar.get with jid 20171203223456459201
2017-12-03 22:34:56,482 [salt.minion      ][INFO    ][22724] Starting a new job with PID 22724
2017-12-03 22:34:56,486 [salt.minion      ][INFO    ][22724] Returning information for job: 20171203223456459201
2017-12-03 22:39:36,081 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command state.sls with jid 20171203223936072099
2017-12-03 22:39:36,094 [salt.minion      ][INFO    ][22815] Starting a new job with PID 22815
2017-12-03 22:39:38,440 [salt.state       ][INFO    ][22815] Loading fresh modules for state activity
2017-12-03 22:39:38,468 [salt.fileclient  ][INFO    ][22815] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-03 22:39:38,492 [salt.fileclient  ][INFO    ][22815] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-03 22:39:38,789 [salt.state       ][INFO    ][22815] Running state [attr] at time 22:39:38.788616
2017-12-03 22:39:38,789 [salt.state       ][INFO    ][22815] Executing state pkg.installed for attr
2017-12-03 22:39:38,790 [salt.loaded.int.module.cmdmod][INFO    ][22815] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:39:39,067 [salt.loaded.int.module.cmdmod][INFO    ][22815] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-03 22:39:40,398 [salt.loaded.int.module.cmdmod][INFO    ][22815] 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-03 22:39:41,718 [salt.loaded.int.module.cmdmod][INFO    ][22815] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:39:41,746 [salt.state       ][INFO    ][22815] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-12-03 22:39:41,756 [salt.state       ][INFO    ][22815] Loading fresh modules for state activity
2017-12-03 22:39:41,772 [salt.state       ][INFO    ][22815] Completed state [attr] at time 22:39:41.772353 duration_in_ms=2983.737
2017-12-03 22:39:41,778 [salt.state       ][INFO    ][22815] Running state [glusterfs-server] at time 22:39:41.777602
2017-12-03 22:39:41,778 [salt.state       ][INFO    ][22815] Executing state pkg.installed for glusterfs-server
2017-12-03 22:39:42,003 [salt.loaded.int.module.cmdmod][INFO    ][22815] 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-03 22:39:46,188 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command saltutil.find_job with jid 20171203223946168397
2017-12-03 22:39:46,199 [salt.minion      ][INFO    ][23646] Starting a new job with PID 23646
2017-12-03 22:39:46,212 [salt.minion      ][INFO    ][23646] Returning information for job: 20171203223946168397
2017-12-03 22:39:51,897 [salt.loaded.int.module.cmdmod][INFO    ][22815] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:39:51,927 [salt.state       ][INFO    ][22815] 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-03 22:39:51,937 [salt.state       ][INFO    ][22815] Loading fresh modules for state activity
2017-12-03 22:39:51,954 [salt.state       ][INFO    ][22815] Completed state [glusterfs-server] at time 22:39:51.953521 duration_in_ms=10175.918
2017-12-03 22:39:51,958 [salt.state       ][INFO    ][22815] Running state [bc] at time 22:39:51.958336
2017-12-03 22:39:51,959 [salt.state       ][INFO    ][22815] Executing state pkg.installed for bc
2017-12-03 22:39:52,230 [salt.loaded.int.module.cmdmod][INFO    ][22815] 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-03 22:39:53,657 [salt.loaded.int.module.cmdmod][INFO    ][22815] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:39:53,686 [salt.state       ][INFO    ][22815] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-12-03 22:39:53,697 [salt.state       ][INFO    ][22815] Loading fresh modules for state activity
2017-12-03 22:39:53,713 [salt.state       ][INFO    ][22815] Completed state [bc] at time 22:39:53.713315 duration_in_ms=1754.977
2017-12-03 22:39:53,784 [salt.state       ][INFO    ][22815] Running state [glusterfs-server] at time 22:39:53.783922
2017-12-03 22:39:53,784 [salt.state       ][INFO    ][22815] Executing state service.running for glusterfs-server
2017-12-03 22:39:53,786 [salt.loaded.int.module.cmdmod][INFO    ][22815] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-03 22:39:53,795 [salt.loaded.int.module.cmdmod][INFO    ][22815] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-03 22:39:53,802 [salt.loaded.int.module.cmdmod][INFO    ][22815] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-03 22:39:53,810 [salt.state       ][INFO    ][22815] The service glusterfs-server is already running
2017-12-03 22:39:53,811 [salt.state       ][INFO    ][22815] Completed state [glusterfs-server] at time 22:39:53.810495 duration_in_ms=26.573
2017-12-03 22:39:53,812 [salt.state       ][INFO    ][22815] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:39:53.812226
2017-12-03 22:39:53,812 [salt.state       ][INFO    ][22815] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-03 22:39:53,817 [salt.state       ][INFO    ][22815] File changed:
New file
2017-12-03 22:39:53,817 [salt.state       ][INFO    ][22815] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:39:53.817176 duration_in_ms=4.951
2017-12-03 22:39:53,817 [salt.state       ][INFO    ][22815] Running state [/srv/glusterfs/glance] at time 22:39:53.817373
2017-12-03 22:39:53,818 [salt.state       ][INFO    ][22815] Executing state file.directory for /srv/glusterfs/glance
2017-12-03 22:39:53,818 [salt.state       ][INFO    ][22815] {'/srv/glusterfs/glance': 'New Dir'}
2017-12-03 22:39:53,818 [salt.state       ][INFO    ][22815] Completed state [/srv/glusterfs/glance] at time 22:39:53.818369 duration_in_ms=0.995
2017-12-03 22:39:53,819 [salt.state       ][INFO    ][22815] Running state [/srv/glusterfs/keystone-keys] at time 22:39:53.818541
2017-12-03 22:39:53,819 [salt.state       ][INFO    ][22815] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-03 22:39:53,819 [salt.state       ][INFO    ][22815] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-12-03 22:39:53,819 [salt.state       ][INFO    ][22815] Completed state [/srv/glusterfs/keystone-keys] at time 22:39:53.819306 duration_in_ms=0.765
2017-12-03 22:39:53,819 [salt.state       ][INFO    ][22815] Running state [/srv/glusterfs/nova_instances] at time 22:39:53.819473
2017-12-03 22:39:53,820 [salt.state       ][INFO    ][22815] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-03 22:39:53,820 [salt.state       ][INFO    ][22815] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-12-03 22:39:53,820 [salt.state       ][INFO    ][22815] Completed state [/srv/glusterfs/nova_instances] at time 22:39:53.820213 duration_in_ms=0.74
2017-12-03 22:39:53,820 [salt.state       ][INFO    ][22815] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:39:53.820373
2017-12-03 22:39:53,821 [salt.state       ][INFO    ][22815] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-03 22:39:53,821 [salt.state       ][INFO    ][22815] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-12-03 22:39:53,821 [salt.state       ][INFO    ][22815] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:39:53.821197 duration_in_ms=0.823
2017-12-03 22:39:53,822 [salt.minion      ][INFO    ][22815] Returning information for job: 20171203223936072099
2017-12-03 22:39:58,301 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command test.ping with jid 20171203223958291716
2017-12-03 22:39:58,312 [salt.minion      ][INFO    ][25605] Starting a new job with PID 25605
2017-12-03 22:39:58,347 [salt.minion      ][INFO    ][25605] Returning information for job: 20171203223958291716
2017-12-03 22:39:58,474 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command state.sls with jid 20171203223958462976
2017-12-03 22:39:58,483 [salt.minion      ][INFO    ][25610] Starting a new job with PID 25610
2017-12-03 22:40:00,789 [salt.state       ][INFO    ][25610] Loading fresh modules for state activity
2017-12-03 22:40:00,817 [salt.fileclient  ][INFO    ][25610] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-03 22:40:00,857 [salt.fileclient  ][INFO    ][25610] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-03 22:40:00,946 [salt.fileclient  ][INFO    ][25610] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-03 22:40:00,972 [salt.fileclient  ][INFO    ][25610] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-03 22:40:01,280 [salt.state       ][INFO    ][25610] Running state [attr] at time 22:40:01.280226
2017-12-03 22:40:01,281 [salt.state       ][INFO    ][25610] Executing state pkg.installed for attr
2017-12-03 22:40:01,281 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:40:01,562 [salt.state       ][INFO    ][25610] Package attr is already installed
2017-12-03 22:40:01,562 [salt.state       ][INFO    ][25610] Completed state [attr] at time 22:40:01.562332 duration_in_ms=282.107
2017-12-03 22:40:01,563 [salt.state       ][INFO    ][25610] Running state [glusterfs-server] at time 22:40:01.562573
2017-12-03 22:40:01,563 [salt.state       ][INFO    ][25610] Executing state pkg.installed for glusterfs-server
2017-12-03 22:40:01,566 [salt.state       ][INFO    ][25610] Package glusterfs-server is already installed
2017-12-03 22:40:01,567 [salt.state       ][INFO    ][25610] Completed state [glusterfs-server] at time 22:40:01.566560 duration_in_ms=3.986
2017-12-03 22:40:01,567 [salt.state       ][INFO    ][25610] Running state [bc] at time 22:40:01.566734
2017-12-03 22:40:01,567 [salt.state       ][INFO    ][25610] Executing state pkg.installed for bc
2017-12-03 22:40:01,571 [salt.state       ][INFO    ][25610] Package bc is already installed
2017-12-03 22:40:01,571 [salt.state       ][INFO    ][25610] Completed state [bc] at time 22:40:01.570655 duration_in_ms=3.921
2017-12-03 22:40:01,572 [salt.state       ][INFO    ][25610] Running state [glusterfs-server] at time 22:40:01.571610
2017-12-03 22:40:01,572 [salt.state       ][INFO    ][25610] Executing state service.running for glusterfs-server
2017-12-03 22:40:01,572 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-03 22:40:01,581 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-03 22:40:01,627 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-03 22:40:01,640 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-03 22:40:01,646 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-03 22:40:01,653 [salt.state       ][INFO    ][25610] The service glusterfs-server is already running
2017-12-03 22:40:01,654 [salt.state       ][INFO    ][25610] Completed state [glusterfs-server] at time 22:40:01.653496 duration_in_ms=81.886
2017-12-03 22:40:01,655 [salt.state       ][INFO    ][25610] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:40:01.654889
2017-12-03 22:40:01,655 [salt.state       ][INFO    ][25610] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-03 22:40:01,657 [salt.state       ][INFO    ][25610] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-03 22:40:01,657 [salt.state       ][INFO    ][25610] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:40:01.657276 duration_in_ms=2.387
2017-12-03 22:40:01,658 [salt.state       ][INFO    ][25610] Running state [/srv/glusterfs/glance] at time 22:40:01.657476
2017-12-03 22:40:01,658 [salt.state       ][INFO    ][25610] Executing state file.directory for /srv/glusterfs/glance
2017-12-03 22:40:01,658 [salt.state       ][INFO    ][25610] Directory /srv/glusterfs/glance is in the correct state
2017-12-03 22:40:01,658 [salt.state       ][INFO    ][25610] Completed state [/srv/glusterfs/glance] at time 22:40:01.658202 duration_in_ms=0.726
2017-12-03 22:40:01,658 [salt.state       ][INFO    ][25610] Running state [/srv/glusterfs/keystone-keys] at time 22:40:01.658372
2017-12-03 22:40:01,659 [salt.state       ][INFO    ][25610] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-03 22:40:01,659 [salt.state       ][INFO    ][25610] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-03 22:40:01,659 [salt.state       ][INFO    ][25610] Completed state [/srv/glusterfs/keystone-keys] at time 22:40:01.659011 duration_in_ms=0.64
2017-12-03 22:40:01,659 [salt.state       ][INFO    ][25610] Running state [/srv/glusterfs/nova_instances] at time 22:40:01.659179
2017-12-03 22:40:01,659 [salt.state       ][INFO    ][25610] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-03 22:40:01,660 [salt.state       ][INFO    ][25610] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-03 22:40:01,660 [salt.state       ][INFO    ][25610] Completed state [/srv/glusterfs/nova_instances] at time 22:40:01.659805 duration_in_ms=0.626
2017-12-03 22:40:01,660 [salt.state       ][INFO    ][25610] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:40:01.659969
2017-12-03 22:40:01,660 [salt.state       ][INFO    ][25610] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-03 22:40:01,660 [salt.state       ][INFO    ][25610] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-03 22:40:01,661 [salt.state       ][INFO    ][25610] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:40:01.660598 duration_in_ms=0.629
2017-12-03 22:40:01,724 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command ['git', '--version'] in directory '/root'
2017-12-03 22:40:01,806 [salt.state       ][INFO    ][25610] Running state [sleep 5] at time 22:40:01.805999
2017-12-03 22:40:01,806 [salt.state       ][INFO    ][25610] Executing state cmd.wait for sleep 5
2017-12-03 22:40:01,806 [salt.state       ][INFO    ][25610] No changes made for sleep 5
2017-12-03 22:40:01,807 [salt.state       ][INFO    ][25610] Completed state [sleep 5] at time 22:40:01.806598 duration_in_ms=0.601
2017-12-03 22:40:01,807 [salt.state       ][INFO    ][25610] Running state [192.168.10.143] at time 22:40:01.807121
2017-12-03 22:40:01,807 [salt.state       ][INFO    ][25610] Executing state glusterfs.peered for 192.168.10.143
2017-12-03 22:40:01,808 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:01,816 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:01,873 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:01,881 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:01,945 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:01,954 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:02,007 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:02,015 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:02,068 [salt.state       ][INFO    ][25610] {'new': {'192.168.10.143': []}, 'old': None}
2017-12-03 22:40:02,068 [salt.state       ][INFO    ][25610] Completed state [192.168.10.143] at time 22:40:02.067870 duration_in_ms=260.748
2017-12-03 22:40:02,071 [salt.state       ][INFO    ][25610] Running state [192.168.10.142] at time 22:40:02.070947
2017-12-03 22:40:02,071 [salt.state       ][INFO    ][25610] Executing state glusterfs.peered for 192.168.10.142
2017-12-03 22:40:02,072 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:02,079 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:02,134 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:02,140 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:02,197 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:02,205 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:02,258 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:02,267 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:02,321 [salt.state       ][INFO    ][25610] Peering with localhost is not needed
2017-12-03 22:40:02,322 [salt.state       ][INFO    ][25610] Completed state [192.168.10.142] at time 22:40:02.321581 duration_in_ms=250.632
2017-12-03 22:40:02,325 [salt.state       ][INFO    ][25610] Running state [192.168.10.141] at time 22:40:02.324533
2017-12-03 22:40:02,325 [salt.state       ][INFO    ][25610] Executing state glusterfs.peered for 192.168.10.141
2017-12-03 22:40:02,325 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:02,333 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:02,389 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:02,397 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:02,460 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:02,469 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:02,523 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:02,531 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:02,586 [salt.state       ][INFO    ][25610] {'new': {'192.168.10.143': [], '192.168.10.141': []}, 'old': {'192.168.10.143': []}}
2017-12-03 22:40:02,586 [salt.state       ][INFO    ][25610] Completed state [192.168.10.141] at time 22:40:02.586207 duration_in_ms=261.673
2017-12-03 22:40:02,587 [salt.state       ][INFO    ][25610] Running state [glance] at time 22:40:02.587296
2017-12-03 22:40:02,588 [salt.state       ][INFO    ][25610] Executing state glusterfs.created for glance
2017-12-03 22:40:02,588 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:02,596 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:02,649 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:02,657 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:02,736 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:02,744 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:04,935 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:04,943 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:04,997 [salt.state       ][INFO    ][25610] {'new': ['glance'], 'old': []}
2017-12-03 22:40:04,997 [salt.state       ][INFO    ][25610] Completed state [glance] at time 22:40:04.997373 duration_in_ms=2410.063
2017-12-03 22:40:05,004 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:05.003369
2017-12-03 22:40:05,005 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 22:40:05,007 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:05,063 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-12-03 22:40:05,161 [salt.state       ][INFO    ][25610] {'pid': 25873, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:05,161 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:05.160972 duration_in_ms=157.615
2017-12-03 22:40:05,162 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:40:05.161693
2017-12-03 22:40:05,162 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-03 22:40:05,163 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 22:40:05,219 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-12-03 22:40:05,318 [salt.state       ][INFO    ][25610] {'pid': 25912, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:05,318 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:40:05.318223 duration_in_ms=156.53
2017-12-03 22:40:05,319 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:40:05.318901
2017-12-03 22:40:05,319 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-03 22:40:05,320 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 22:40:05,374 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-12-03 22:40:05,471 [salt.state       ][INFO    ][25610] {'pid': 25949, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:05,472 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:40:05.471716 duration_in_ms=152.814
2017-12-03 22:40:05,472 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:05.472372
2017-12-03 22:40:05,473 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 22:40:05,473 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 22:40:05,529 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-12-03 22:40:05,628 [salt.state       ][INFO    ][25610] {'pid': 25986, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:05,628 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:05.627997 duration_in_ms=155.624
2017-12-03 22:40:05,629 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:05.628651
2017-12-03 22:40:05,629 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 22:40:05,629 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:05,686 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-12-03 22:40:05,793 [salt.state       ][INFO    ][25610] {'pid': 26023, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:05,793 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:05.792891 duration_in_ms=164.239
2017-12-03 22:40:05,794 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:40:05.793572
2017-12-03 22:40:05,794 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-03 22:40:05,794 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 22:40:05,849 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-12-03 22:40:05,963 [salt.state       ][INFO    ][25610] {'pid': 26060, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:05,964 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:40:05.963606 duration_in_ms=170.034
2017-12-03 22:40:05,965 [salt.state       ][INFO    ][25610] Running state [glance] at time 22:40:05.965216
2017-12-03 22:40:05,966 [salt.state       ][INFO    ][25610] Executing state glusterfs.started for glance
2017-12-03 22:40:05,966 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:05,974 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:06,030 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:06,038 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:06,095 [salt.state       ][INFO    ][25610] Volume glance is already started
2017-12-03 22:40:06,096 [salt.state       ][INFO    ][25610] Completed state [glance] at time 22:40:06.095619 duration_in_ms=130.402
2017-12-03 22:40:06,097 [salt.state       ][INFO    ][25610] Running state [keystone-keys] at time 22:40:06.096965
2017-12-03 22:40:06,097 [salt.state       ][INFO    ][25610] Executing state glusterfs.created for keystone-keys
2017-12-03 22:40:06,098 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:06,104 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:06,155 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:06,161 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:06,243 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:06,250 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:08,351 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:08,359 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:08,415 [salt.state       ][INFO    ][25610] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-12-03 22:40:08,415 [salt.state       ][INFO    ][25610] Completed state [keystone-keys] at time 22:40:08.415028 duration_in_ms=2318.063
2017-12-03 22:40:08,421 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:40:08.421261
2017-12-03 22:40:08,422 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-03 22:40:08,422 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 22:40:08,480 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-12-03 22:40:08,539 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command saltutil.find_job with jid 20171203224008521631
2017-12-03 22:40:08,551 [salt.minion      ][INFO    ][26223] Starting a new job with PID 26223
2017-12-03 22:40:08,563 [salt.minion      ][INFO    ][26223] Returning information for job: 20171203224008521631
2017-12-03 22:40:08,587 [salt.state       ][INFO    ][25610] {'pid': 26211, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:08,588 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:40:08.587560 duration_in_ms=166.298
2017-12-03 22:40:08,588 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:08.588205
2017-12-03 22:40:08,588 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 22:40:08,589 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:08,647 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-12-03 22:40:08,749 [salt.state       ][INFO    ][25610] {'pid': 26253, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:08,749 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:08.749240 duration_in_ms=161.033
2017-12-03 22:40:08,750 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:08.749885
2017-12-03 22:40:08,750 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 22:40:08,751 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 22:40:08,808 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-12-03 22:40:08,908 [salt.state       ][INFO    ][25610] {'pid': 26292, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:08,909 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:08.908660 duration_in_ms=158.774
2017-12-03 22:40:08,909 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:08.909359
2017-12-03 22:40:08,910 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 22:40:08,910 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:08,964 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-12-03 22:40:09,067 [salt.state       ][INFO    ][25610] {'pid': 26329, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:09,067 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:09.066916 duration_in_ms=157.545
2017-12-03 22:40:09,068 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:40:09.067548
2017-12-03 22:40:09,068 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-03 22:40:09,068 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 22:40:09,124 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-12-03 22:40:09,228 [salt.state       ][INFO    ][25610] {'pid': 26366, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:09,228 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:40:09.227812 duration_in_ms=160.264
2017-12-03 22:40:09,228 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:40:09.228458
2017-12-03 22:40:09,229 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-03 22:40:09,229 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 22:40:09,285 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-12-03 22:40:09,387 [salt.state       ][INFO    ][25610] {'pid': 26403, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:09,387 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:40:09.386811 duration_in_ms=158.353
2017-12-03 22:40:09,388 [salt.state       ][INFO    ][25610] Running state [keystone-keys] at time 22:40:09.388308
2017-12-03 22:40:09,389 [salt.state       ][INFO    ][25610] Executing state glusterfs.started for keystone-keys
2017-12-03 22:40:09,389 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:09,398 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:09,455 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:09,463 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:09,522 [salt.state       ][INFO    ][25610] Volume keystone-keys is already started
2017-12-03 22:40:09,523 [salt.state       ][INFO    ][25610] Completed state [keystone-keys] at time 22:40:09.522631 duration_in_ms=134.323
2017-12-03 22:40:09,524 [salt.state       ][INFO    ][25610] Running state [nova_instances] at time 22:40:09.523771
2017-12-03 22:40:09,524 [salt.state       ][INFO    ][25610] Executing state glusterfs.created for nova_instances
2017-12-03 22:40:09,524 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:09,533 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:09,587 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:09,593 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:09,675 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:09,683 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:12,785 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:12,794 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:12,850 [salt.state       ][INFO    ][25610] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-12-03 22:40:12,851 [salt.state       ][INFO    ][25610] Completed state [nova_instances] at time 22:40:12.850665 duration_in_ms=3326.894
2017-12-03 22:40:12,856 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:12.855524
2017-12-03 22:40:12,856 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 22:40:12,856 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:12,912 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-12-03 22:40:13,015 [salt.state       ][INFO    ][25610] {'pid': 26556, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:13,015 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:13.015230 duration_in_ms=159.707
2017-12-03 22:40:13,016 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 22:40:13.015828
2017-12-03 22:40:13,016 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-03 22:40:13,017 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 22:40:13,073 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-12-03 22:40:13,179 [salt.state       ][INFO    ][25610] {'pid': 26595, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:13,179 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 22:40:13.179032 duration_in_ms=163.204
2017-12-03 22:40:13,180 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 22:40:13.179667
2017-12-03 22:40:13,180 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-03 22:40:13,180 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 22:40:13,236 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'True'' in directory '/root'
2017-12-03 22:40:13,340 [salt.state       ][INFO    ][25610] {'pid': 26632, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:13,340 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 22:40:13.340285 duration_in_ms=160.618
2017-12-03 22:40:13,341 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:13.340970
2017-12-03 22:40:13,341 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 22:40:13,342 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 22:40:13,397 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-12-03 22:40:13,506 [salt.state       ][INFO    ][25610] {'pid': 26669, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:13,506 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:13.505769 duration_in_ms=164.798
2017-12-03 22:40:13,506 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 22:40:13.506404
2017-12-03 22:40:13,507 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-03 22:40:13,507 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 22:40:13,562 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'True'' in directory '/root'
2017-12-03 22:40:13,670 [salt.state       ][INFO    ][25610] {'pid': 26707, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:13,670 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 22:40:13.670155 duration_in_ms=163.75
2017-12-03 22:40:13,671 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:13.670807
2017-12-03 22:40:13,671 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 22:40:13,672 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:13,727 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-12-03 22:40:13,833 [salt.state       ][INFO    ][25610] {'pid': 26744, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:13,833 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:13.833411 duration_in_ms=162.604
2017-12-03 22:40:13,835 [salt.state       ][INFO    ][25610] Running state [nova_instances] at time 22:40:13.834901
2017-12-03 22:40:13,835 [salt.state       ][INFO    ][25610] Executing state glusterfs.started for nova_instances
2017-12-03 22:40:13,836 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:13,843 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:13,897 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:13,905 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:13,964 [salt.state       ][INFO    ][25610] Volume nova_instances is already started
2017-12-03 22:40:13,965 [salt.state       ][INFO    ][25610] Completed state [nova_instances] at time 22:40:13.964553 duration_in_ms=129.652
2017-12-03 22:40:13,966 [salt.state       ][INFO    ][25610] Running state [keystone-credential-keys] at time 22:40:13.965742
2017-12-03 22:40:13,966 [salt.state       ][INFO    ][25610] Executing state glusterfs.created for keystone-credential-keys
2017-12-03 22:40:13,967 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:13,975 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:14,031 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:14,038 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:14,120 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:14,129 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:16,236 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:16,245 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:16,299 [salt.state       ][INFO    ][25610] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-12-03 22:40:16,299 [salt.state       ][INFO    ][25610] Completed state [keystone-credential-keys] at time 22:40:16.299319 duration_in_ms=2333.576
2017-12-03 22:40:16,304 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:40:16.304132
2017-12-03 22:40:16,304 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-03 22:40:16,305 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 22:40:16,360 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-12-03 22:40:16,470 [salt.state       ][INFO    ][25610] {'pid': 26903, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:16,470 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:40:16.470156 duration_in_ms=166.023
2017-12-03 22:40:16,471 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:16.470805
2017-12-03 22:40:16,471 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 22:40:16,472 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 22:40:16,528 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-12-03 22:40:16,640 [salt.state       ][INFO    ][25610] {'pid': 26941, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:16,640 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:16.640023 duration_in_ms=169.218
2017-12-03 22:40:16,641 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:16.640785
2017-12-03 22:40:16,641 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 22:40:16,642 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:16,699 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-12-03 22:40:16,825 [salt.state       ][INFO    ][25610] {'pid': 26978, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:16,825 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:16.825207 duration_in_ms=184.421
2017-12-03 22:40:16,826 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:40:16.825870
2017-12-03 22:40:16,826 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-03 22:40:16,827 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 22:40:16,884 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-12-03 22:40:17,010 [salt.state       ][INFO    ][25610] {'pid': 27017, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:17,011 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:40:17.010452 duration_in_ms=184.582
2017-12-03 22:40:17,011 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:17.011056
2017-12-03 22:40:17,011 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 22:40:17,012 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:17,067 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-12-03 22:40:17,194 [salt.state       ][INFO    ][25610] {'pid': 27054, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:17,195 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:17.194672 duration_in_ms=183.615
2017-12-03 22:40:17,195 [salt.state       ][INFO    ][25610] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:40:17.195393
2017-12-03 22:40:17,196 [salt.state       ][INFO    ][25610] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-03 22:40:17,196 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 22:40:17,253 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-12-03 22:40:17,367 [salt.state       ][INFO    ][25610] {'pid': 27091, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-03 22:40:17,367 [salt.state       ][INFO    ][25610] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:40:17.367070 duration_in_ms=171.676
2017-12-03 22:40:17,369 [salt.state       ][INFO    ][25610] Running state [keystone-credential-keys] at time 22:40:17.368615
2017-12-03 22:40:17,369 [salt.state       ][INFO    ][25610] Executing state glusterfs.started for keystone-credential-keys
2017-12-03 22:40:17,369 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:17,377 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:17,430 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:17,438 [salt.loaded.int.module.cmdmod][INFO    ][25610] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:17,496 [salt.state       ][INFO    ][25610] Volume keystone-credential-keys is already started
2017-12-03 22:40:17,496 [salt.state       ][INFO    ][25610] Completed state [keystone-credential-keys] at time 22:40:17.496345 duration_in_ms=127.728
2017-12-03 22:40:17,499 [salt.minion      ][INFO    ][25610] Returning information for job: 20171203223958462976
2017-12-03 22:40:29,829 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command test.ping with jid 20171203224029820799
2017-12-03 22:40:29,842 [salt.minion      ][INFO    ][27147] Starting a new job with PID 27147
2017-12-03 22:40:29,876 [salt.minion      ][INFO    ][27147] Returning information for job: 20171203224029820799
2017-12-03 22:40:30,005 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command cmd.run with jid 20171203224029991790
2017-12-03 22:40:30,016 [salt.minion      ][INFO    ][27152] Starting a new job with PID 27152
2017-12-03 22:40:30,019 [salt.loaded.int.module.cmdmod][INFO    ][27152] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-03 22:40:30,137 [salt.minion      ][INFO    ][27152] Returning information for job: 20171203224029991790
2017-12-03 23:23:40,908 [salt.utils.schedule][INFO    ][20743] Running scheduled job: __mine_interval
2017-12-03 23:38:25,644 [salt.minion      ][INFO    ][20743] User sudo_ubuntu Executing command cp.push_dir with jid 20171203233825634867
2017-12-03 23:38:25,659 [salt.minion      ][INFO    ][27843] Starting a new job with PID 27843
