2017-10-12 05:40:35,729 [salt.cli.daemons ][WARNING ][2530] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-12 05:56:39,029 [salt.state       ][ERROR   ][3870] No contents found in top file
2017-10-12 05:56:57,011 [salt.utils.parsers][WARNING ][2530] Minion received a SIGTERM. Exiting.
2017-10-12 05:59:09,188 [salt.cli.daemons ][WARNING ][3359] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-12 06:03:16,255 [salt.transport.ipc][ERROR   ][3359] Exception occurred while handling stream: [Errno 0] Success
2017-10-12 06:04:11,545 [salt.loaded.int.module.cmdmod][ERROR   ][11191] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-10-12 06:04:11,545 [salt.loaded.int.module.cmdmod][ERROR   ][11191] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-10-12 06:04:11,545 [salt.loaded.int.module.cmdmod][ERROR   ][11191] retcode: 1
2017-10-12 06:04:11,546 [salt.state       ][ERROR   ][11191] {'pid': 16085, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-10-12 06:04:15,202 [py.warnings      ][WARNING ][16126] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-12 06:16:41,774 [salt.loaded.int.module.cmdmod][ERROR   ][16126] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-12 06:16:41,775 [salt.loaded.int.module.cmdmod][ERROR   ][16126] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-12 06:16:48,585 [salt.loaded.int.module.cmdmod][ERROR   ][16126] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-12 06:16:48,586 [salt.loaded.int.module.cmdmod][ERROR   ][16126] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-12 06:16:57,199 [salt.loaded.int.module.cmdmod][ERROR   ][16126] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-12 06:16:57,200 [salt.loaded.int.module.cmdmod][ERROR   ][16126] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-12 06:17:05,982 [salt.loaded.int.module.cmdmod][ERROR   ][16126] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-12 06:17:05,982 [salt.loaded.int.module.cmdmod][ERROR   ][16126] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-12 06:17:12,154 [salt.loaded.int.module.cmdmod][ERROR   ][16126] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-10-12 06:17:14,297 [salt.loaded.int.module.cmdmod][INFO    ][23849] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-12 06:17:14,304 [salt.loaded.int.module.cmdmod][INFO    ][23849] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-12 06:17:14,313 [salt.loaded.int.module.cmdmod][INFO    ][23849] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-10-12 06:17:14,321 [salt.utils.parsers][WARNING ][3359] Minion received a SIGTERM. Exiting.
2017-10-12 06:17:14,576 [salt.cli.daemons ][INFO    ][23940] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-10-12 06:17:15,101 [salt.minion      ][INFO    ][23940] Creating minion process manager
2017-10-12 06:17:15,102 [salt.cli.daemons ][WARNING ][23940] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-12 06:17:15,102 [salt.cli.daemons ][INFO    ][23940] The Salt Minion is starting up
2017-10-12 06:17:15,102 [salt.minion      ][INFO    ][23940] Minion is starting as user 'root'
2017-10-12 06:17:15,103 [salt.utils.event ][INFO    ][23940] Starting pull socket on /var/run/salt/minion/minion_event_4fcafbd0f5_pull.ipc
2017-10-12 06:17:15,946 [salt.loaded.int.module.cmdmod][INFO    ][23940] Executing command ['date', '+%z'] in directory '/root'
2017-10-12 06:17:15,954 [salt.utils.schedule][INFO    ][23940] Updating job settings for scheduled job: __mine_interval
2017-10-12 06:17:15,956 [salt.minion      ][INFO    ][23940] Added mine.update to scheduler
2017-10-12 06:17:16,131 [salt.minion      ][INFO    ][23940] Minion is ready to receive requests!
2017-10-12 06:17:17,132 [salt.utils.schedule][INFO    ][23940] Running scheduled job: __mine_interval
2017-10-12 06:17:19,420 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171012061719405762
2017-10-12 06:17:19,436 [salt.minion      ][INFO    ][24070] Starting a new job with PID 24070
2017-10-12 06:17:21,917 [salt.state       ][INFO    ][24070] Loading fresh modules for state activity
2017-10-12 06:17:21,939 [salt.state       ][ERROR   ][24070] No contents found in top file
2017-10-12 06:17:21,940 [salt.utils.extmods][INFO    ][24070] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-12 06:17:21,943 [salt.utils.extmods][INFO    ][24070] Syncing beacons for environment 'base'
2017-10-12 06:17:21,943 [salt.utils.extmods][INFO    ][24070] Loading cache from salt://_beacons, for base)
2017-10-12 06:17:21,943 [salt.fileclient  ][INFO    ][24070] Caching directory '_beacons/' for environment 'base'
2017-10-12 06:17:21,978 [salt.utils.extmods][INFO    ][24070] Syncing modules for environment 'base'
2017-10-12 06:17:21,979 [salt.utils.extmods][INFO    ][24070] Loading cache from salt://_modules, for base)
2017-10-12 06:17:21,979 [salt.fileclient  ][INFO    ][24070] Caching directory '_modules/' for environment 'base'
2017-10-12 06:17:22,034 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-12 06:17:22,048 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-12 06:17:22,098 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-12 06:17:22,118 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-12 06:17:22,130 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-12 06:17:22,142 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-12 06:17:22,161 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-12 06:17:22,181 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-12 06:17:22,199 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-12 06:17:22,210 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-12 06:17:22,221 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-12 06:17:22,231 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-12 06:17:22,246 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-12 06:17:22,256 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-12 06:17:22,266 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-12 06:17:22,281 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-12 06:17:22,292 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-12 06:17:22,304 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-12 06:17:22,314 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-12 06:17:22,334 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-12 06:17:22,349 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-12 06:17:22,360 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-12 06:17:22,370 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-12 06:17:22,386 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-12 06:17:22,395 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-12 06:17:22,412 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-12 06:17:22,424 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-12 06:17:22,443 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-12 06:17:22,453 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-12 06:17:22,463 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-12 06:17:22,477 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-12 06:17:22,491 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-12 06:17:22,493 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-12 06:17:22,494 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-12 06:17:22,494 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-12 06:17:22,494 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-12 06:17:22,495 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-12 06:17:22,496 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-12 06:17:22,496 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-12 06:17:22,497 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-12 06:17:22,501 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-12 06:17:22,502 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-12 06:17:22,502 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-12 06:17:22,502 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-12 06:17:22,503 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-12 06:17:22,503 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-12 06:17:22,503 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-12 06:17:22,504 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-12 06:17:22,504 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-12 06:17:22,504 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-12 06:17:22,505 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-12 06:17:22,505 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-12 06:17:22,505 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-12 06:17:22,506 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-12 06:17:22,513 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-12 06:17:22,513 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-12 06:17:22,514 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-12 06:17:22,520 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-12 06:17:22,520 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-12 06:17:22,520 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-12 06:17:22,521 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-12 06:17:22,521 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-12 06:17:22,522 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-12 06:17:22,522 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-10-12 06:17:22,522 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-12 06:17:22,523 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-12 06:17:22,527 [salt.utils.extmods][INFO    ][24070] Syncing states for environment 'base'
2017-10-12 06:17:22,528 [salt.utils.extmods][INFO    ][24070] Loading cache from salt://_states, for base)
2017-10-12 06:17:22,528 [salt.fileclient  ][INFO    ][24070] Caching directory '_states/' for environment 'base'
2017-10-12 06:17:22,567 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-12 06:17:22,586 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-12 06:17:22,597 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-12 06:17:22,608 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-12 06:17:22,621 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-12 06:17:22,637 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-12 06:17:22,649 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-12 06:17:22,660 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-12 06:17:22,671 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-12 06:17:22,683 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-12 06:17:22,704 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-12 06:17:22,714 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-12 06:17:22,732 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-12 06:17:22,744 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-12 06:17:22,764 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-12 06:17:22,775 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-12 06:17:22,795 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-12 06:17:22,806 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-12 06:17:22,816 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-12 06:17:22,826 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-12 06:17:22,836 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-12 06:17:22,845 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-12 06:17:22,856 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-12 06:17:22,875 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-12 06:17:22,885 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-12 06:17:22,905 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-12 06:17:22,915 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-12 06:17:22,925 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-12 06:17:23,089 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-12 06:17:23,092 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-12 06:17:23,092 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-12 06:17:23,093 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-12 06:17:23,093 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-12 06:17:23,093 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-12 06:17:23,093 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-12 06:17:23,094 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-12 06:17:23,094 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-12 06:17:23,094 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-12 06:17:23,094 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-12 06:17:23,094 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-12 06:17:23,095 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-12 06:17:23,095 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-12 06:17:23,095 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-12 06:17:23,095 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-12 06:17:23,096 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-12 06:17:23,096 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-12 06:17:23,096 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-12 06:17:23,096 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-12 06:17:23,096 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-12 06:17:23,097 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-12 06:17:23,097 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-12 06:17:23,097 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-12 06:17:23,097 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-12 06:17:23,097 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-12 06:17:23,098 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-12 06:17:23,098 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-12 06:17:23,098 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-12 06:17:23,098 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-12 06:17:23,099 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-12 06:17:23,101 [salt.utils.extmods][INFO    ][24070] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-12 06:17:23,103 [salt.utils.extmods][INFO    ][24070] Syncing sdb for environment 'base'
2017-10-12 06:17:23,103 [salt.utils.extmods][INFO    ][24070] Loading cache from salt://_sdb, for base)
2017-10-12 06:17:23,103 [salt.fileclient  ][INFO    ][24070] Caching directory '_sdb/' for environment 'base'
2017-10-12 06:17:23,130 [salt.utils.extmods][INFO    ][24070] Syncing grains for environment 'base'
2017-10-12 06:17:23,130 [salt.utils.extmods][INFO    ][24070] Loading cache from salt://_grains, for base)
2017-10-12 06:17:23,130 [salt.fileclient  ][INFO    ][24070] Caching directory '_grains/' for environment 'base'
2017-10-12 06:17:23,262 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-12 06:17:23,302 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-12 06:17:23,343 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-12 06:17:23,449 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-12 06:17:23,506 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-12 06:17:23,523 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-12 06:17:23,641 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-12 06:17:23,686 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-12 06:17:23,710 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-12 06:17:23,866 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-12 06:17:23,933 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-12 06:17:24,028 [salt.fileclient  ][INFO    ][24070] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-12 06:17:24,031 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-12 06:17:24,137 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-12 06:17:24,200 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-12 06:17:24,231 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-12 06:17:24,240 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-12 06:17:24,261 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-12 06:17:24,294 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-12 06:17:24,327 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-12 06:17:24,416 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-12 06:17:24,488 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-12 06:17:24,519 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-12 06:17:24,562 [salt.utils.extmods][INFO    ][24070] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-12 06:17:24,564 [salt.utils.extmods][INFO    ][24070] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-12 06:17:24,567 [salt.utils.extmods][INFO    ][24070] Syncing renderers for environment 'base'
2017-10-12 06:17:24,567 [salt.utils.extmods][INFO    ][24070] Loading cache from salt://_renderers, for base)
2017-10-12 06:17:24,567 [salt.fileclient  ][INFO    ][24070] Caching directory '_renderers/' for environment 'base'
2017-10-12 06:17:24,599 [salt.utils.extmods][INFO    ][24070] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-12 06:17:24,601 [salt.utils.extmods][INFO    ][24070] Syncing returners for environment 'base'
2017-10-12 06:17:24,601 [salt.utils.extmods][INFO    ][24070] Loading cache from salt://_returners, for base)
2017-10-12 06:17:24,601 [salt.fileclient  ][INFO    ][24070] Caching directory '_returners/' for environment 'base'
2017-10-12 06:17:24,632 [salt.utils.extmods][INFO    ][24070] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-12 06:17:24,634 [salt.utils.extmods][INFO    ][24070] Syncing output for environment 'base'
2017-10-12 06:17:24,634 [salt.utils.extmods][INFO    ][24070] Loading cache from salt://_output, for base)
2017-10-12 06:17:24,634 [salt.fileclient  ][INFO    ][24070] Caching directory '_output/' for environment 'base'
2017-10-12 06:17:24,662 [salt.utils.extmods][INFO    ][24070] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-12 06:17:24,664 [salt.utils.extmods][INFO    ][24070] Syncing utils for environment 'base'
2017-10-12 06:17:24,664 [salt.utils.extmods][INFO    ][24070] Loading cache from salt://_utils, for base)
2017-10-12 06:17:24,664 [salt.fileclient  ][INFO    ][24070] Caching directory '_utils/' for environment 'base'
2017-10-12 06:17:24,704 [salt.utils.extmods][INFO    ][24070] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-12 06:17:24,706 [salt.utils.extmods][INFO    ][24070] Syncing log_handlers for environment 'base'
2017-10-12 06:17:24,706 [salt.utils.extmods][INFO    ][24070] Loading cache from salt://_log_handlers, for base)
2017-10-12 06:17:24,707 [salt.fileclient  ][INFO    ][24070] Caching directory '_log_handlers/' for environment 'base'
2017-10-12 06:17:24,759 [salt.utils.extmods][INFO    ][24070] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-12 06:17:24,761 [salt.utils.extmods][INFO    ][24070] Syncing proxy for environment 'base'
2017-10-12 06:17:24,762 [salt.utils.extmods][INFO    ][24070] Loading cache from salt://_proxy, for base)
2017-10-12 06:17:24,762 [salt.fileclient  ][INFO    ][24070] Caching directory '_proxy/' for environment 'base'
2017-10-12 06:17:24,793 [salt.utils.extmods][INFO    ][24070] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-12 06:17:24,795 [salt.utils.extmods][INFO    ][24070] Syncing engines for environment 'base'
2017-10-12 06:17:24,795 [salt.utils.extmods][INFO    ][24070] Loading cache from salt://_engines, for base)
2017-10-12 06:17:24,796 [salt.fileclient  ][INFO    ][24070] Caching directory '_engines/' for environment 'base'
2017-10-12 06:17:24,842 [salt.minion      ][INFO    ][24070] Returning information for job: 20171012061719405762
2017-10-12 06:17:27,354 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command state.sls with jid 20171012061727341446
2017-10-12 06:17:27,370 [salt.minion      ][INFO    ][24204] Starting a new job with PID 24204
2017-10-12 06:17:27,786 [salt.state       ][INFO    ][24204] Loading fresh modules for state activity
2017-10-12 06:17:27,813 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-12 06:17:27,833 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-12 06:17:27,905 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-12 06:17:27,977 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-12 06:17:27,992 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-12 06:17:28,026 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-12 06:17:28,078 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-12 06:17:28,101 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-12 06:17:28,147 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-12 06:17:28,164 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-12 06:17:28,176 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-12 06:17:28,190 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-12 06:17:28,198 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-12 06:17:28,219 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-12 06:17:28,234 [py.warnings      ][WARNING ][24204] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-12 06:17:28,235 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'salt-minion --version' in directory '/root'
2017-10-12 06:17:28,480 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-12 06:17:28,500 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-12 06:17:28,532 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-12 06:17:28,544 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-12 06:17:28,586 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-12 06:17:28,618 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-12 06:17:28,683 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-12 06:17:28,701 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-12 06:17:28,993 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-12 06:17:29,012 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-12 06:17:29,057 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-12 06:17:29,076 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-12 06:17:29,101 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-12 06:17:29,118 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-12 06:17:29,124 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-12 06:17:29,158 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-12 06:17:29,174 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'salt-minion --version' in directory '/root'
2017-10-12 06:17:29,422 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-12 06:17:29,442 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-12 06:17:29,456 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-12 06:17:29,469 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-12 06:17:29,517 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-12 06:17:29,556 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-12 06:17:29,641 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-12 06:17:29,698 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-12 06:17:30,113 [salt.state       ][INFO    ][24204] Running state [salt-minion] at time 06:17:30.112797
2017-10-12 06:17:30,113 [salt.state       ][INFO    ][24204] Executing state pkg.installed for salt-minion
2017-10-12 06:17:30,114 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-12 06:17:30,384 [salt.state       ][INFO    ][24204] Package salt-minion is already installed
2017-10-12 06:17:30,384 [salt.state       ][INFO    ][24204] Completed state [salt-minion] at time 06:17:30.384377 duration_in_ms=271.579
2017-10-12 06:17:30,385 [salt.state       ][INFO    ][24204] Running state [salt_minion_dependency_packages] at time 06:17:30.384613
2017-10-12 06:17:30,385 [salt.state       ][INFO    ][24204] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-12 06:17:30,387 [salt.state       ][INFO    ][24204] All specified packages are already installed
2017-10-12 06:17:30,388 [salt.state       ][INFO    ][24204] Completed state [salt_minion_dependency_packages] at time 06:17:30.387512 duration_in_ms=2.9
2017-10-12 06:17:30,389 [salt.state       ][INFO    ][24204] Running state [/etc/salt/minion.d/minion.conf] at time 06:17:30.389102
2017-10-12 06:17:30,389 [salt.state       ][INFO    ][24204] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-12 06:17:30,423 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-12 06:17:30,473 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-12 06:17:30,517 [salt.fileclient  ][INFO    ][24204] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-12 06:17:30,550 [salt.state       ][INFO    ][24204] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-12 06:17:30,550 [salt.state       ][INFO    ][24204] Completed state [/etc/salt/minion.d/minion.conf] at time 06:17:30.550438 duration_in_ms=161.336
2017-10-12 06:17:30,551 [salt.state       ][INFO    ][24204] Running state [/etc/salt/minion.d/_virt.conf] at time 06:17:30.550742
2017-10-12 06:17:30,551 [salt.state       ][INFO    ][24204] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-12 06:17:30,564 [salt.state       ][INFO    ][24204] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-12 06:17:30,564 [salt.state       ][INFO    ][24204] Completed state [/etc/salt/minion.d/_virt.conf] at time 06:17:30.564213 duration_in_ms=13.472
2017-10-12 06:17:30,566 [salt.state       ][INFO    ][24204] Running state [salt-minion] at time 06:17:30.565632
2017-10-12 06:17:30,566 [salt.state       ][INFO    ][24204] Executing state service.running for salt-minion
2017-10-12 06:17:30,566 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-12 06:17:30,585 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-12 06:17:30,601 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-12 06:17:30,610 [salt.state       ][INFO    ][24204] The service salt-minion is already running
2017-10-12 06:17:30,610 [salt.state       ][INFO    ][24204] Completed state [salt-minion] at time 06:17:30.609849 duration_in_ms=44.217
2017-10-12 06:17:30,611 [salt.state       ][INFO    ][24204] Running state [/etc/salt/grains.d] at time 06:17:30.611115
2017-10-12 06:17:30,611 [salt.state       ][INFO    ][24204] Executing state file.directory for /etc/salt/grains.d
2017-10-12 06:17:30,612 [salt.state       ][INFO    ][24204] Directory /etc/salt/grains.d is in the correct state
2017-10-12 06:17:30,612 [salt.state       ][INFO    ][24204] Completed state [/etc/salt/grains.d] at time 06:17:30.612036 duration_in_ms=0.92
2017-10-12 06:17:30,613 [salt.state       ][INFO    ][24204] Running state [/etc/salt/grains] at time 06:17:30.612497
2017-10-12 06:17:30,616 [salt.state       ][INFO    ][24204] Executing state file.managed for /etc/salt/grains
2017-10-12 06:17:30,616 [salt.state       ][INFO    ][24204] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-12 06:17:30,616 [salt.state       ][INFO    ][24204] Completed state [/etc/salt/grains] at time 06:17:30.616232 duration_in_ms=3.735
2017-10-12 06:17:30,617 [salt.state       ][INFO    ][24204] Running state [/etc/salt/grains.d/placeholder] at time 06:17:30.616536
2017-10-12 06:17:30,617 [salt.state       ][INFO    ][24204] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-12 06:17:30,617 [salt.state       ][INFO    ][24204] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-12 06:17:30,617 [salt.state       ][INFO    ][24204] Completed state [/etc/salt/grains.d/placeholder] at time 06:17:30.617178 duration_in_ms=0.642
2017-10-12 06:17:30,617 [salt.state       ][INFO    ][24204] Running state [/etc/salt/grains.d/sphinx] at time 06:17:30.617466
2017-10-12 06:17:30,618 [salt.state       ][INFO    ][24204] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-12 06:17:30,644 [salt.state       ][INFO    ][24204] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.143
               - 127.0.0.1
               - 192.168.11.252
-              - 192.168.122.1
         system:
           name: System
           param:

2017-10-12 06:17:30,644 [salt.state       ][INFO    ][24204] Completed state [/etc/salt/grains.d/sphinx] at time 06:17:30.643790 duration_in_ms=26.311
2017-10-12 06:17:30,644 [salt.state       ][INFO    ][24204] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:17:30.644404
2017-10-12 06:17:30,645 [salt.state       ][INFO    ][24204] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-12 06:17:30,645 [salt.state       ][INFO    ][24204] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-12 06:17:30,645 [salt.state       ][INFO    ][24204] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:17:30.644934 duration_in_ms=0.529
2017-10-12 06:17:30,645 [salt.state       ][INFO    ][24204] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:17:30.645077
2017-10-12 06:17:30,645 [salt.state       ][INFO    ][24204] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-12 06:17:30,646 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-10-12 06:17:30,730 [salt.state       ][INFO    ][24204] {'pid': 24255, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-12 06:17:30,731 [salt.state       ][INFO    ][24204] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:17:30.730616 duration_in_ms=85.539
2017-10-12 06:17:30,731 [salt.state       ][INFO    ][24204] Running state [/etc/salt/grains.d/dns_records] at time 06:17:30.731081
2017-10-12 06:17:30,731 [salt.state       ][INFO    ][24204] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-12 06:17:30,829 [salt.state       ][INFO    ][24204] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-12 06:17:30,830 [salt.state       ][INFO    ][24204] Completed state [/etc/salt/grains.d/dns_records] at time 06:17:30.829487 duration_in_ms=98.406
2017-10-12 06:17:30,830 [salt.state       ][INFO    ][24204] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 06:17:30.830201
2017-10-12 06:17:30,830 [salt.state       ][INFO    ][24204] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-12 06:17:30,831 [salt.state       ][INFO    ][24204] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-12 06:17:30,831 [salt.state       ][INFO    ][24204] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 06:17:30.830856 duration_in_ms=0.655
2017-10-12 06:17:30,831 [salt.state       ][INFO    ][24204] Running state [/etc/salt/grains.d/salt] at time 06:17:30.831178
2017-10-12 06:17:30,831 [salt.state       ][INFO    ][24204] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-12 06:17:30,872 [salt.state       ][INFO    ][24204] File /etc/salt/grains.d/salt is in the correct state
2017-10-12 06:17:30,872 [salt.state       ][INFO    ][24204] Completed state [/etc/salt/grains.d/salt] at time 06:17:30.872180 duration_in_ms=41.0
2017-10-12 06:17:30,873 [salt.state       ][INFO    ][24204] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 06:17:30.872896
2017-10-12 06:17:30,873 [salt.state       ][INFO    ][24204] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-12 06:17:30,874 [salt.state       ][INFO    ][24204] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-12 06:17:30,874 [salt.state       ][INFO    ][24204] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 06:17:30.873729 duration_in_ms=0.833
2017-10-12 06:17:30,875 [salt.state       ][INFO    ][24204] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:17:30.875074
2017-10-12 06:17:30,875 [salt.state       ][INFO    ][24204] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-12 06:17:30,876 [salt.state       ][INFO    ][24204] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-12 06:17:30,876 [salt.state       ][INFO    ][24204] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:17:30.875999 duration_in_ms=0.925
2017-10-12 06:17:30,876 [salt.state       ][INFO    ][24204] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:17:30.876233
2017-10-12 06:17:30,877 [salt.state       ][INFO    ][24204] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-12 06:17:30,878 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-10-12 06:17:30,888 [salt.state       ][INFO    ][24204] {'pid': 24257, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-12 06:17:30,888 [salt.state       ][INFO    ][24204] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:17:30.888145 duration_in_ms=11.912
2017-10-12 06:17:30,889 [salt.state       ][INFO    ][24204] Running state [mine.update] at time 06:17:30.888797
2017-10-12 06:17:30,889 [salt.state       ][INFO    ][24204] Executing state module.wait for mine.update
2017-10-12 06:17:30,889 [salt.state       ][INFO    ][24204] No changes made for mine.update
2017-10-12 06:17:30,889 [salt.state       ][INFO    ][24204] Completed state [mine.update] at time 06:17:30.889407 duration_in_ms=0.611
2017-10-12 06:17:30,890 [salt.state       ][INFO    ][24204] Running state [mine.update] at time 06:17:30.889568
2017-10-12 06:17:30,890 [salt.state       ][INFO    ][24204] Executing state module.mod_watch for mine.update
2017-10-12 06:17:31,413 [salt.state       ][INFO    ][24204] {'ret': True}
2017-10-12 06:17:31,413 [salt.state       ][INFO    ][24204] Completed state [mine.update] at time 06:17:31.412941 duration_in_ms=523.373
2017-10-12 06:17:31,413 [salt.state       ][INFO    ][24204] Running state [ca-certificates] at time 06:17:31.413232
2017-10-12 06:17:31,414 [salt.state       ][INFO    ][24204] Executing state pkg.installed for ca-certificates
2017-10-12 06:17:31,417 [salt.state       ][INFO    ][24204] Package ca-certificates is already installed
2017-10-12 06:17:31,417 [salt.state       ][INFO    ][24204] Completed state [ca-certificates] at time 06:17:31.416966 duration_in_ms=3.734
2017-10-12 06:17:31,418 [salt.state       ][INFO    ][24204] Running state [update-ca-certificates] at time 06:17:31.417604
2017-10-12 06:17:31,418 [salt.state       ][INFO    ][24204] Executing state cmd.wait for update-ca-certificates
2017-10-12 06:17:31,418 [salt.state       ][INFO    ][24204] No changes made for update-ca-certificates
2017-10-12 06:17:31,418 [salt.state       ][INFO    ][24204] Completed state [update-ca-certificates] at time 06:17:31.418291 duration_in_ms=0.686
2017-10-12 06:17:31,419 [salt.state       ][INFO    ][24204] Running state [libvirt-dev] at time 06:17:31.418499
2017-10-12 06:17:31,419 [salt.state       ][INFO    ][24204] Executing state pkg.installed for libvirt-dev
2017-10-12 06:17:31,421 [salt.state       ][INFO    ][24204] Package libvirt-dev is already installed
2017-10-12 06:17:31,422 [salt.state       ][INFO    ][24204] Completed state [libvirt-dev] at time 06:17:31.421642 duration_in_ms=3.143
2017-10-12 06:17:31,422 [salt.state       ][INFO    ][24204] Running state [pkg-config] at time 06:17:31.421850
2017-10-12 06:17:31,422 [salt.state       ][INFO    ][24204] Executing state pkg.installed for pkg-config
2017-10-12 06:17:31,425 [salt.state       ][INFO    ][24204] Package pkg-config is already installed
2017-10-12 06:17:31,425 [salt.state       ][INFO    ][24204] Completed state [pkg-config] at time 06:17:31.425022 duration_in_ms=3.172
2017-10-12 06:17:31,425 [salt.state       ][INFO    ][24204] Running state [virtng.init] at time 06:17:31.425227
2017-10-12 06:17:31,425 [salt.state       ][INFO    ][24204] Executing state module.run for virtng.init
2017-10-12 06:17:31,500 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command ['git', '--version'] in directory '/root'
2017-10-12 06:17:31,613 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:17:31,635 [salt.state       ][INFO    ][24204] unless execution succeeded
2017-10-12 06:17:31,635 [salt.state       ][INFO    ][24204] Completed state [virtng.init] at time 06:17:31.634917 duration_in_ms=209.688
2017-10-12 06:17:31,635 [salt.state       ][INFO    ][24204] Running state [virt.set_autostart] at time 06:17:31.635177
2017-10-12 06:17:31,635 [salt.state       ][INFO    ][24204] Executing state module.run for virt.set_autostart
2017-10-12 06:17:31,637 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:17:31,655 [salt.state       ][INFO    ][24204] unless execution succeeded
2017-10-12 06:17:31,655 [salt.state       ][INFO    ][24204] Completed state [virt.set_autostart] at time 06:17:31.655018 duration_in_ms=19.839
2017-10-12 06:17:31,655 [salt.state       ][INFO    ][24204] Running state [virtng.init] at time 06:17:31.655258
2017-10-12 06:17:31,656 [salt.state       ][INFO    ][24204] Executing state module.run for virtng.init
2017-10-12 06:17:31,658 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:17:31,672 [salt.state       ][INFO    ][24204] unless execution succeeded
2017-10-12 06:17:31,672 [salt.state       ][INFO    ][24204] Completed state [virtng.init] at time 06:17:31.672275 duration_in_ms=17.017
2017-10-12 06:17:31,673 [salt.state       ][INFO    ][24204] Running state [virt.set_autostart] at time 06:17:31.672518
2017-10-12 06:17:31,673 [salt.state       ][INFO    ][24204] Executing state module.run for virt.set_autostart
2017-10-12 06:17:31,675 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:17:31,692 [salt.state       ][INFO    ][24204] unless execution succeeded
2017-10-12 06:17:31,692 [salt.state       ][INFO    ][24204] Completed state [virt.set_autostart] at time 06:17:31.692174 duration_in_ms=19.655
2017-10-12 06:17:31,692 [salt.state       ][INFO    ][24204] Running state [virtng.init] at time 06:17:31.692408
2017-10-12 06:17:31,693 [salt.state       ][INFO    ][24204] Executing state module.run for virtng.init
2017-10-12 06:17:31,695 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:17:31,710 [salt.state       ][INFO    ][24204] unless execution succeeded
2017-10-12 06:17:31,711 [salt.state       ][INFO    ][24204] Completed state [virtng.init] at time 06:17:31.710641 duration_in_ms=18.231
2017-10-12 06:17:31,711 [salt.state       ][INFO    ][24204] Running state [virt.set_autostart] at time 06:17:31.710865
2017-10-12 06:17:31,711 [salt.state       ][INFO    ][24204] Executing state module.run for virt.set_autostart
2017-10-12 06:17:31,713 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:17:31,729 [salt.state       ][INFO    ][24204] unless execution succeeded
2017-10-12 06:17:31,738 [salt.state       ][INFO    ][24204] Completed state [virt.set_autostart] at time 06:17:31.737849 duration_in_ms=26.984
2017-10-12 06:17:31,738 [salt.state       ][INFO    ][24204] Running state [virtng.init] at time 06:17:31.738088
2017-10-12 06:17:31,738 [salt.state       ][INFO    ][24204] Executing state module.run for virtng.init
2017-10-12 06:17:31,740 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:17:31,756 [salt.state       ][INFO    ][24204] unless execution succeeded
2017-10-12 06:17:31,756 [salt.state       ][INFO    ][24204] Completed state [virtng.init] at time 06:17:31.756071 duration_in_ms=17.967
2017-10-12 06:17:31,756 [salt.state       ][INFO    ][24204] Running state [virt.set_autostart] at time 06:17:31.756302
2017-10-12 06:17:31,757 [salt.state       ][INFO    ][24204] Executing state module.run for virt.set_autostart
2017-10-12 06:17:31,758 [salt.loaded.int.module.cmdmod][INFO    ][24204] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:17:31,775 [salt.state       ][INFO    ][24204] unless execution succeeded
2017-10-12 06:17:31,776 [salt.state       ][INFO    ][24204] Completed state [virt.set_autostart] at time 06:17:31.775619 duration_in_ms=19.316
2017-10-12 06:17:31,778 [salt.minion      ][INFO    ][24204] Returning information for job: 20171012061727341446
2017-10-12 06:18:49,252 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command state.sls with jid 20171012061849237995
2017-10-12 06:18:49,270 [salt.minion      ][INFO    ][24326] Starting a new job with PID 24326
2017-10-12 06:18:51,680 [salt.state       ][INFO    ][24326] Loading fresh modules for state activity
2017-10-12 06:18:51,706 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-12 06:18:51,724 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-12 06:18:51,788 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-12 06:18:51,851 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-12 06:18:51,865 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-12 06:18:51,890 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-12 06:18:51,941 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-12 06:18:51,958 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-12 06:18:51,1000 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-12 06:18:52,017 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-12 06:18:52,030 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-12 06:18:52,044 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-12 06:18:52,051 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-12 06:18:52,070 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-12 06:18:52,084 [py.warnings      ][WARNING ][24326] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-12 06:18:52,085 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'salt-minion --version' in directory '/root'
2017-10-12 06:18:52,344 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-12 06:18:52,364 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-12 06:18:52,378 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-12 06:18:52,390 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-12 06:18:52,437 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-12 06:18:52,477 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-12 06:18:52,535 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-12 06:18:52,557 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-12 06:18:52,610 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-12 06:18:52,629 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-12 06:18:52,674 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-12 06:18:52,691 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-12 06:18:52,704 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-12 06:18:52,718 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-12 06:18:52,725 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-12 06:18:52,752 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-12 06:18:52,768 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'salt-minion --version' in directory '/root'
2017-10-12 06:18:53,032 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-12 06:18:53,053 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-12 06:18:53,065 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-12 06:18:53,077 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-12 06:18:53,123 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-12 06:18:53,159 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-12 06:18:53,222 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-12 06:18:53,277 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-12 06:18:53,574 [salt.state       ][INFO    ][24326] Running state [salt-minion] at time 06:18:53.574200
2017-10-12 06:18:53,575 [salt.state       ][INFO    ][24326] Executing state pkg.installed for salt-minion
2017-10-12 06:18:53,575 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-12 06:18:53,820 [salt.state       ][INFO    ][24326] Package salt-minion is already installed
2017-10-12 06:18:53,820 [salt.state       ][INFO    ][24326] Completed state [salt-minion] at time 06:18:53.819888 duration_in_ms=245.688
2017-10-12 06:18:53,820 [salt.state       ][INFO    ][24326] Running state [salt_minion_dependency_packages] at time 06:18:53.820122
2017-10-12 06:18:53,820 [salt.state       ][INFO    ][24326] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-12 06:18:53,823 [salt.state       ][INFO    ][24326] All specified packages are already installed
2017-10-12 06:18:53,823 [salt.state       ][INFO    ][24326] Completed state [salt_minion_dependency_packages] at time 06:18:53.823016 duration_in_ms=2.894
2017-10-12 06:18:53,824 [salt.state       ][INFO    ][24326] Running state [/etc/salt/minion.d/minion.conf] at time 06:18:53.824458
2017-10-12 06:18:53,825 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-12 06:18:53,849 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-12 06:18:53,894 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-12 06:18:53,936 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-12 06:18:53,968 [salt.state       ][INFO    ][24326] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-12 06:18:53,968 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/minion.d/minion.conf] at time 06:18:53.968180 duration_in_ms=143.722
2017-10-12 06:18:53,968 [salt.state       ][INFO    ][24326] Running state [/etc/salt/minion.d/_virt.conf] at time 06:18:53.968450
2017-10-12 06:18:53,969 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-12 06:18:53,973 [salt.state       ][INFO    ][24326] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-12 06:18:53,973 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/minion.d/_virt.conf] at time 06:18:53.973326 duration_in_ms=4.876
2017-10-12 06:18:53,975 [salt.state       ][INFO    ][24326] Running state [salt-minion] at time 06:18:53.974633
2017-10-12 06:18:53,975 [salt.state       ][INFO    ][24326] Executing state service.running for salt-minion
2017-10-12 06:18:53,975 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-12 06:18:53,993 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-12 06:18:54,002 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-12 06:18:54,011 [salt.state       ][INFO    ][24326] The service salt-minion is already running
2017-10-12 06:18:54,012 [salt.state       ][INFO    ][24326] Completed state [salt-minion] at time 06:18:54.011484 duration_in_ms=36.851
2017-10-12 06:18:54,013 [salt.state       ][INFO    ][24326] Running state [/etc/salt/grains.d] at time 06:18:54.012711
2017-10-12 06:18:54,013 [salt.state       ][INFO    ][24326] Executing state file.directory for /etc/salt/grains.d
2017-10-12 06:18:54,013 [salt.state       ][INFO    ][24326] Directory /etc/salt/grains.d is in the correct state
2017-10-12 06:18:54,014 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/grains.d] at time 06:18:54.013537 duration_in_ms=0.825
2017-10-12 06:18:54,014 [salt.state       ][INFO    ][24326] Running state [/etc/salt/grains] at time 06:18:54.013912
2017-10-12 06:18:54,014 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/grains
2017-10-12 06:18:54,014 [salt.state       ][INFO    ][24326] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-12 06:18:54,015 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/grains] at time 06:18:54.014515 duration_in_ms=0.604
2017-10-12 06:18:54,015 [salt.state       ][INFO    ][24326] Running state [/etc/salt/grains.d/placeholder] at time 06:18:54.014761
2017-10-12 06:18:54,015 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-12 06:18:54,015 [salt.state       ][INFO    ][24326] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-12 06:18:54,015 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/grains.d/placeholder] at time 06:18:54.015315 duration_in_ms=0.555
2017-10-12 06:18:54,016 [salt.state       ][INFO    ][24326] Running state [/etc/salt/grains.d/sphinx] at time 06:18:54.015577
2017-10-12 06:18:54,016 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-12 06:18:54,029 [salt.state       ][INFO    ][24326] File /etc/salt/grains.d/sphinx is in the correct state
2017-10-12 06:18:54,030 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/grains.d/sphinx] at time 06:18:54.029527 duration_in_ms=13.949
2017-10-12 06:18:54,030 [salt.state       ][INFO    ][24326] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:18:54.030034
2017-10-12 06:18:54,030 [salt.state       ][INFO    ][24326] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-12 06:18:54,030 [salt.state       ][INFO    ][24326] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-12 06:18:54,031 [salt.state       ][INFO    ][24326] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:18:54.030493 duration_in_ms=0.459
2017-10-12 06:18:54,031 [salt.state       ][INFO    ][24326] Running state [/etc/salt/grains.d/dns_records] at time 06:18:54.030736
2017-10-12 06:18:54,031 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-12 06:18:54,035 [salt.state       ][INFO    ][24326] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-12 06:18:54,036 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/grains.d/dns_records] at time 06:18:54.035506 duration_in_ms=4.77
2017-10-12 06:18:54,036 [salt.state       ][INFO    ][24326] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 06:18:54.036021
2017-10-12 06:18:54,036 [salt.state       ][INFO    ][24326] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-12 06:18:54,036 [salt.state       ][INFO    ][24326] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-12 06:18:54,037 [salt.state       ][INFO    ][24326] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 06:18:54.036481 duration_in_ms=0.461
2017-10-12 06:18:54,037 [salt.state       ][INFO    ][24326] Running state [/etc/salt/grains.d/salt] at time 06:18:54.036729
2017-10-12 06:18:54,037 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-12 06:18:54,050 [salt.state       ][INFO    ][24326] File /etc/salt/grains.d/salt is in the correct state
2017-10-12 06:18:54,050 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/grains.d/salt] at time 06:18:54.050362 duration_in_ms=13.634
2017-10-12 06:18:54,051 [salt.state       ][INFO    ][24326] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 06:18:54.050857
2017-10-12 06:18:54,051 [salt.state       ][INFO    ][24326] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-12 06:18:54,051 [salt.state       ][INFO    ][24326] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-12 06:18:54,051 [salt.state       ][INFO    ][24326] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 06:18:54.051312 duration_in_ms=0.456
2017-10-12 06:18:54,052 [salt.state       ][INFO    ][24326] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:18:54.052415
2017-10-12 06:18:54,053 [salt.state       ][INFO    ][24326] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-12 06:18:54,053 [salt.state       ][INFO    ][24326] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-12 06:18:54,053 [salt.state       ][INFO    ][24326] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:18:54.052878 duration_in_ms=0.462
2017-10-12 06:18:54,053 [salt.state       ][INFO    ][24326] Running state [mine.update] at time 06:18:54.053254
2017-10-12 06:18:54,053 [salt.state       ][INFO    ][24326] Executing state module.wait for mine.update
2017-10-12 06:18:54,054 [salt.state       ][INFO    ][24326] No changes made for mine.update
2017-10-12 06:18:54,054 [salt.state       ][INFO    ][24326] Completed state [mine.update] at time 06:18:54.053670 duration_in_ms=0.417
2017-10-12 06:18:54,054 [salt.state       ][INFO    ][24326] Running state [ca-certificates] at time 06:18:54.053800
2017-10-12 06:18:54,054 [salt.state       ][INFO    ][24326] Executing state pkg.installed for ca-certificates
2017-10-12 06:18:54,057 [salt.state       ][INFO    ][24326] Package ca-certificates is already installed
2017-10-12 06:18:54,057 [salt.state       ][INFO    ][24326] Completed state [ca-certificates] at time 06:18:54.056934 duration_in_ms=3.134
2017-10-12 06:18:54,057 [salt.state       ][INFO    ][24326] Running state [update-ca-certificates] at time 06:18:54.057324
2017-10-12 06:18:54,057 [salt.state       ][INFO    ][24326] Executing state cmd.wait for update-ca-certificates
2017-10-12 06:18:54,058 [salt.state       ][INFO    ][24326] No changes made for update-ca-certificates
2017-10-12 06:18:54,058 [salt.state       ][INFO    ][24326] Completed state [update-ca-certificates] at time 06:18:54.057760 duration_in_ms=0.436
2017-10-12 06:18:54,058 [salt.state       ][INFO    ][24326] Running state [libvirt-dev] at time 06:18:54.057893
2017-10-12 06:18:54,058 [salt.state       ][INFO    ][24326] Executing state pkg.installed for libvirt-dev
2017-10-12 06:18:54,061 [salt.state       ][INFO    ][24326] Package libvirt-dev is already installed
2017-10-12 06:18:54,061 [salt.state       ][INFO    ][24326] Completed state [libvirt-dev] at time 06:18:54.060686 duration_in_ms=2.793
2017-10-12 06:18:54,061 [salt.state       ][INFO    ][24326] Running state [pkg-config] at time 06:18:54.060820
2017-10-12 06:18:54,061 [salt.state       ][INFO    ][24326] Executing state pkg.installed for pkg-config
2017-10-12 06:18:54,064 [salt.state       ][INFO    ][24326] Package pkg-config is already installed
2017-10-12 06:18:54,064 [salt.state       ][INFO    ][24326] Completed state [pkg-config] at time 06:18:54.063617 duration_in_ms=2.796
2017-10-12 06:18:54,064 [salt.state       ][INFO    ][24326] Running state [virtng.init] at time 06:18:54.063753
2017-10-12 06:18:54,064 [salt.state       ][INFO    ][24326] Executing state module.run for virtng.init
2017-10-12 06:18:54,098 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command ['git', '--version'] in directory '/root'
2017-10-12 06:18:54,184 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:18:54,202 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-10-12 06:18:54,202 [salt.state       ][INFO    ][24326] Completed state [virtng.init] at time 06:18:54.202213 duration_in_ms=138.457
2017-10-12 06:18:54,202 [salt.state       ][INFO    ][24326] Running state [virt.set_autostart] at time 06:18:54.202424
2017-10-12 06:18:54,203 [salt.state       ][INFO    ][24326] Executing state module.run for virt.set_autostart
2017-10-12 06:18:54,205 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:18:54,221 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-10-12 06:18:54,221 [salt.state       ][INFO    ][24326] Completed state [virt.set_autostart] at time 06:18:54.221033 duration_in_ms=18.608
2017-10-12 06:18:54,221 [salt.state       ][INFO    ][24326] Running state [virtng.init] at time 06:18:54.221249
2017-10-12 06:18:54,221 [salt.state       ][INFO    ][24326] Executing state module.run for virtng.init
2017-10-12 06:18:54,223 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:18:54,238 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-10-12 06:18:54,238 [salt.state       ][INFO    ][24326] Completed state [virtng.init] at time 06:18:54.238274 duration_in_ms=17.025
2017-10-12 06:18:54,239 [salt.state       ][INFO    ][24326] Running state [virt.set_autostart] at time 06:18:54.238475
2017-10-12 06:18:54,239 [salt.state       ][INFO    ][24326] Executing state module.run for virt.set_autostart
2017-10-12 06:18:54,241 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:18:54,256 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-10-12 06:18:54,256 [salt.state       ][INFO    ][24326] Completed state [virt.set_autostart] at time 06:18:54.255995 duration_in_ms=17.519
2017-10-12 06:18:54,256 [salt.state       ][INFO    ][24326] Running state [virtng.init] at time 06:18:54.256201
2017-10-12 06:18:54,256 [salt.state       ][INFO    ][24326] Executing state module.run for virtng.init
2017-10-12 06:18:54,258 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:18:54,272 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-10-12 06:18:54,272 [salt.state       ][INFO    ][24326] Completed state [virtng.init] at time 06:18:54.271875 duration_in_ms=15.674
2017-10-12 06:18:54,272 [salt.state       ][INFO    ][24326] Running state [virt.set_autostart] at time 06:18:54.272098
2017-10-12 06:18:54,272 [salt.state       ][INFO    ][24326] Executing state module.run for virt.set_autostart
2017-10-12 06:18:54,274 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:18:54,289 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-10-12 06:18:54,289 [salt.state       ][INFO    ][24326] Completed state [virt.set_autostart] at time 06:18:54.288951 duration_in_ms=16.852
2017-10-12 06:18:54,289 [salt.state       ][INFO    ][24326] Running state [virtng.init] at time 06:18:54.289152
2017-10-12 06:18:54,289 [salt.state       ][INFO    ][24326] Executing state module.run for virtng.init
2017-10-12 06:18:54,291 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:18:54,306 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-10-12 06:18:54,306 [salt.state       ][INFO    ][24326] Completed state [virtng.init] at time 06:18:54.306452 duration_in_ms=17.3
2017-10-12 06:18:54,307 [salt.state       ][INFO    ][24326] Running state [virt.set_autostart] at time 06:18:54.306661
2017-10-12 06:18:54,307 [salt.state       ][INFO    ][24326] Executing state module.run for virt.set_autostart
2017-10-12 06:18:54,309 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-12 06:18:54,323 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-10-12 06:18:54,323 [salt.state       ][INFO    ][24326] Completed state [virt.set_autostart] at time 06:18:54.323203 duration_in_ms=16.542
2017-10-12 06:18:54,325 [salt.minion      ][INFO    ][24326] Returning information for job: 20171012061849237995
2017-10-12 06:19:50,821 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171012061950805520
2017-10-12 06:19:50,840 [salt.minion      ][INFO    ][24425] Starting a new job with PID 24425
2017-10-12 06:19:53,959 [salt.state       ][INFO    ][24425] Loading fresh modules for state activity
2017-10-12 06:19:54,191 [salt.state       ][ERROR   ][24425] No contents found in top file
2017-10-12 06:19:54,192 [salt.utils.extmods][INFO    ][24425] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-12 06:19:54,194 [salt.utils.extmods][INFO    ][24425] Syncing beacons for environment 'base'
2017-10-12 06:19:54,194 [salt.utils.extmods][INFO    ][24425] Loading cache from salt://_beacons, for base)
2017-10-12 06:19:54,195 [salt.fileclient  ][INFO    ][24425] Caching directory '_beacons/' for environment 'base'
2017-10-12 06:19:54,219 [salt.utils.extmods][INFO    ][24425] Syncing modules for environment 'base'
2017-10-12 06:19:54,219 [salt.utils.extmods][INFO    ][24425] Loading cache from salt://_modules, for base)
2017-10-12 06:19:54,219 [salt.fileclient  ][INFO    ][24425] Caching directory '_modules/' for environment 'base'
2017-10-12 06:19:54,257 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-12 06:19:54,437 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-12 06:19:54,446 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-12 06:19:54,457 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-12 06:19:54,468 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-12 06:19:54,500 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-12 06:19:54,520 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-12 06:19:54,528 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-12 06:19:54,537 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-12 06:19:54,568 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-12 06:19:54,592 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-12 06:19:54,607 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-12 06:19:54,624 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-12 06:19:54,635 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-12 06:19:54,643 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-12 06:19:54,679 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-12 06:19:54,689 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-12 06:19:54,716 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-12 06:19:54,754 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-12 06:19:54,764 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-12 06:19:54,787 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-12 06:19:54,809 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-12 06:19:54,846 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-12 06:19:54,888 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-12 06:19:54,926 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-12 06:19:54,961 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-12 06:19:54,988 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-12 06:19:55,034 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-12 06:19:55,045 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-12 06:19:55,081 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-12 06:19:55,094 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-12 06:19:55,102 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-12 06:19:55,105 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-12 06:19:55,105 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-12 06:19:55,106 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-12 06:19:55,106 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-12 06:19:55,106 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-12 06:19:55,107 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-12 06:19:55,107 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-12 06:19:55,107 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-12 06:19:55,107 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-12 06:19:55,108 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-12 06:19:55,108 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-12 06:19:55,108 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-12 06:19:55,108 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-12 06:19:55,108 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-12 06:19:55,109 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-12 06:19:55,109 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-12 06:19:55,109 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-12 06:19:55,109 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-12 06:19:55,109 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-12 06:19:55,110 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-12 06:19:55,110 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-12 06:19:55,110 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-12 06:19:55,111 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-12 06:19:55,111 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-12 06:19:55,111 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-12 06:19:55,112 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-12 06:19:55,112 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-12 06:19:55,112 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-12 06:19:55,112 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-12 06:19:55,112 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-12 06:19:55,113 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-12 06:19:55,113 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-10-12 06:19:55,113 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-12 06:19:55,113 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-12 06:19:55,118 [salt.utils.extmods][INFO    ][24425] Syncing states for environment 'base'
2017-10-12 06:19:55,118 [salt.utils.extmods][INFO    ][24425] Loading cache from salt://_states, for base)
2017-10-12 06:19:55,118 [salt.fileclient  ][INFO    ][24425] Caching directory '_states/' for environment 'base'
2017-10-12 06:19:55,146 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-12 06:19:55,162 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-12 06:19:55,177 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-12 06:19:55,186 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-12 06:19:55,198 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-12 06:19:55,210 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-12 06:19:55,219 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-12 06:19:55,248 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-12 06:19:55,275 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-12 06:19:55,286 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-12 06:19:55,302 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-12 06:19:55,339 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-12 06:19:55,400 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-12 06:19:55,409 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-12 06:19:55,442 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-12 06:19:55,454 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-12 06:19:55,493 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-12 06:19:55,505 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-12 06:19:55,518 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-12 06:19:55,534 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-12 06:19:55,545 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-12 06:19:55,558 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-12 06:19:55,568 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-12 06:19:55,582 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-12 06:19:55,628 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-12 06:19:55,635 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-12 06:19:55,641 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-12 06:19:55,650 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-12 06:19:55,710 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-12 06:19:55,712 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-12 06:19:55,713 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-12 06:19:55,713 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-12 06:19:55,713 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-12 06:19:55,713 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-12 06:19:55,714 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-12 06:19:55,714 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-12 06:19:55,714 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-12 06:19:55,714 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-12 06:19:55,714 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-12 06:19:55,715 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-12 06:19:55,715 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-12 06:19:55,715 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-12 06:19:55,715 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-12 06:19:55,715 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-12 06:19:55,716 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-12 06:19:55,716 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-12 06:19:55,716 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-12 06:19:55,716 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-12 06:19:55,716 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-12 06:19:55,717 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-12 06:19:55,717 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-12 06:19:55,717 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-12 06:19:55,717 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-12 06:19:55,717 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-12 06:19:55,718 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-12 06:19:55,718 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-12 06:19:55,718 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-12 06:19:55,718 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-12 06:19:55,718 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-12 06:19:55,720 [salt.utils.extmods][INFO    ][24425] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-12 06:19:55,723 [salt.utils.extmods][INFO    ][24425] Syncing sdb for environment 'base'
2017-10-12 06:19:55,723 [salt.utils.extmods][INFO    ][24425] Loading cache from salt://_sdb, for base)
2017-10-12 06:19:55,723 [salt.fileclient  ][INFO    ][24425] Caching directory '_sdb/' for environment 'base'
2017-10-12 06:19:55,744 [salt.utils.extmods][INFO    ][24425] Syncing grains for environment 'base'
2017-10-12 06:19:55,745 [salt.utils.extmods][INFO    ][24425] Loading cache from salt://_grains, for base)
2017-10-12 06:19:55,745 [salt.fileclient  ][INFO    ][24425] Caching directory '_grains/' for environment 'base'
2017-10-12 06:19:55,786 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-12 06:19:55,798 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-12 06:19:55,908 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-12 06:19:55,950 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-12 06:19:56,023 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-12 06:19:56,054 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-12 06:19:56,073 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-12 06:19:56,084 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-12 06:19:56,098 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-12 06:19:56,109 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-12 06:19:56,123 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-12 06:19:56,134 [salt.fileclient  ][INFO    ][24425] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-12 06:19:56,137 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-12 06:19:56,137 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-12 06:19:56,137 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-12 06:19:56,137 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-12 06:19:56,138 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-12 06:19:56,138 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-12 06:19:56,138 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-12 06:19:56,138 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-12 06:19:56,139 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-12 06:19:56,139 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-12 06:19:56,139 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-12 06:19:56,139 [salt.utils.extmods][INFO    ][24425] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-12 06:19:56,141 [salt.utils.extmods][INFO    ][24425] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-12 06:19:56,143 [salt.utils.extmods][INFO    ][24425] Syncing renderers for environment 'base'
2017-10-12 06:19:56,143 [salt.utils.extmods][INFO    ][24425] Loading cache from salt://_renderers, for base)
2017-10-12 06:19:56,144 [salt.fileclient  ][INFO    ][24425] Caching directory '_renderers/' for environment 'base'
2017-10-12 06:19:56,162 [salt.utils.extmods][INFO    ][24425] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-12 06:19:56,165 [salt.utils.extmods][INFO    ][24425] Syncing returners for environment 'base'
2017-10-12 06:19:56,165 [salt.utils.extmods][INFO    ][24425] Loading cache from salt://_returners, for base)
2017-10-12 06:19:56,165 [salt.fileclient  ][INFO    ][24425] Caching directory '_returners/' for environment 'base'
2017-10-12 06:19:56,212 [salt.utils.extmods][INFO    ][24425] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-12 06:19:56,214 [salt.utils.extmods][INFO    ][24425] Syncing output for environment 'base'
2017-10-12 06:19:56,214 [salt.utils.extmods][INFO    ][24425] Loading cache from salt://_output, for base)
2017-10-12 06:19:56,214 [salt.fileclient  ][INFO    ][24425] Caching directory '_output/' for environment 'base'
2017-10-12 06:19:56,232 [salt.utils.extmods][INFO    ][24425] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-12 06:19:56,234 [salt.utils.extmods][INFO    ][24425] Syncing utils for environment 'base'
2017-10-12 06:19:56,234 [salt.utils.extmods][INFO    ][24425] Loading cache from salt://_utils, for base)
2017-10-12 06:19:56,234 [salt.fileclient  ][INFO    ][24425] Caching directory '_utils/' for environment 'base'
2017-10-12 06:19:56,268 [salt.utils.extmods][INFO    ][24425] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-12 06:19:56,271 [salt.utils.extmods][INFO    ][24425] Syncing log_handlers for environment 'base'
2017-10-12 06:19:56,271 [salt.utils.extmods][INFO    ][24425] Loading cache from salt://_log_handlers, for base)
2017-10-12 06:19:56,271 [salt.fileclient  ][INFO    ][24425] Caching directory '_log_handlers/' for environment 'base'
2017-10-12 06:19:56,291 [salt.utils.extmods][INFO    ][24425] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-12 06:19:56,293 [salt.utils.extmods][INFO    ][24425] Syncing proxy for environment 'base'
2017-10-12 06:19:56,293 [salt.utils.extmods][INFO    ][24425] Loading cache from salt://_proxy, for base)
2017-10-12 06:19:56,293 [salt.fileclient  ][INFO    ][24425] Caching directory '_proxy/' for environment 'base'
2017-10-12 06:19:56,321 [salt.utils.extmods][INFO    ][24425] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-12 06:19:56,323 [salt.utils.extmods][INFO    ][24425] Syncing engines for environment 'base'
2017-10-12 06:19:56,323 [salt.utils.extmods][INFO    ][24425] Loading cache from salt://_engines, for base)
2017-10-12 06:19:56,324 [salt.fileclient  ][INFO    ][24425] Caching directory '_engines/' for environment 'base'
2017-10-12 06:19:56,347 [salt.minion      ][INFO    ][24425] Returning information for job: 20171012061950805520
2017-10-12 06:31:13,422 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command test.ping with jid 20171012063113408779
2017-10-12 06:31:13,440 [salt.minion      ][INFO    ][25107] Starting a new job with PID 25107
2017-10-12 06:31:13,464 [salt.minion      ][INFO    ][25107] Returning information for job: 20171012063113408779
2017-10-12 06:34:22,553 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command state.sls with jid 20171012063422538035
2017-10-12 06:34:22,569 [salt.minion      ][INFO    ][25158] Starting a new job with PID 25158
2017-10-12 06:34:22,974 [salt.state       ][INFO    ][25158] Loading fresh modules for state activity
2017-10-12 06:34:22,998 [salt.fileclient  ][INFO    ][25158] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-12 06:34:23,015 [salt.fileclient  ][INFO    ][25158] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-12 06:34:23,039 [salt.fileclient  ][INFO    ][25158] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-12 06:34:23,342 [salt.state       ][INFO    ][25158] Running state [lsof] at time 06:34:23.341637
2017-10-12 06:34:23,342 [salt.state       ][INFO    ][25158] Executing state pkg.installed for lsof
2017-10-12 06:34:23,342 [salt.loaded.int.module.cmdmod][INFO    ][25158] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-12 06:34:23,619 [salt.state       ][INFO    ][25158] Package lsof is already installed
2017-10-12 06:34:23,619 [salt.state       ][INFO    ][25158] Completed state [lsof] at time 06:34:23.618945 duration_in_ms=277.308
2017-10-12 06:34:23,619 [salt.state       ][INFO    ][25158] Running state [keepalived] at time 06:34:23.619136
2017-10-12 06:34:23,619 [salt.state       ][INFO    ][25158] Executing state pkg.installed for keepalived
2017-10-12 06:34:23,634 [salt.loaded.int.module.cmdmod][INFO    ][25158] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-12 06:34:25,474 [salt.loaded.int.module.cmdmod][INFO    ][25158] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-10-12 06:34:32,597 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command saltutil.find_job with jid 20171012063432582821
2017-10-12 06:34:32,610 [salt.minion      ][INFO    ][26595] Starting a new job with PID 26595
2017-10-12 06:34:32,619 [salt.minion      ][INFO    ][26595] Returning information for job: 20171012063432582821
2017-10-12 06:34:33,241 [salt.loaded.int.module.cmdmod][INFO    ][25158] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-12 06:34:33,263 [salt.state       ][INFO    ][25158] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-10-12 06:34:33,271 [salt.state       ][INFO    ][25158] Loading fresh modules for state activity
2017-10-12 06:34:33,283 [salt.state       ][INFO    ][25158] Completed state [keepalived] at time 06:34:33.282943 duration_in_ms=9663.807
2017-10-12 06:34:33,302 [salt.state       ][INFO    ][25158] Running state [/etc/keepalived/keepalived.conf] at time 06:34:33.301467
2017-10-12 06:34:33,302 [salt.state       ][INFO    ][25158] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-12 06:34:33,329 [salt.fileclient  ][INFO    ][25158] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-12 06:34:33,360 [salt.fileclient  ][INFO    ][25158] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-12 06:34:33,366 [salt.state       ][INFO    ][25158] File changed:
New file
2017-10-12 06:34:33,366 [salt.state       ][INFO    ][25158] Completed state [/etc/keepalived/keepalived.conf] at time 06:34:33.365862 duration_in_ms=64.394
2017-10-12 06:34:33,428 [salt.state       ][INFO    ][25158] Running state [keepalived] at time 06:34:33.427628
2017-10-12 06:34:33,428 [salt.state       ][INFO    ][25158] Executing state service.running for keepalived
2017-10-12 06:34:33,429 [salt.loaded.int.module.cmdmod][INFO    ][25158] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-12 06:34:33,439 [salt.loaded.int.module.cmdmod][INFO    ][25158] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-12 06:34:33,447 [salt.loaded.int.module.cmdmod][INFO    ][25158] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-12 06:34:33,454 [salt.loaded.int.module.cmdmod][INFO    ][25158] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-12 06:34:33,462 [salt.loaded.int.module.cmdmod][INFO    ][25158] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-10-12 06:34:33,523 [salt.loaded.int.module.cmdmod][INFO    ][25158] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-12 06:34:33,531 [salt.loaded.int.module.cmdmod][INFO    ][25158] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-12 06:34:33,538 [salt.loaded.int.module.cmdmod][INFO    ][25158] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-12 06:34:33,546 [salt.state       ][INFO    ][25158] {'keepalived': True}
2017-10-12 06:34:33,546 [salt.state       ][INFO    ][25158] Completed state [keepalived] at time 06:34:33.546068 duration_in_ms=118.44
2017-10-12 06:34:33,547 [salt.minion      ][INFO    ][25158] Returning information for job: 20171012063422538035
2017-10-12 06:35:16,342 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command pillar.get with jid 20171012063516332679
2017-10-12 06:35:16,363 [salt.minion      ][INFO    ][26730] Starting a new job with PID 26730
2017-10-12 06:35:16,367 [salt.minion      ][INFO    ][26730] Returning information for job: 20171012063516332679
2017-10-12 06:41:03,609 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command state.sls with jid 20171012064103597239
2017-10-12 06:41:03,625 [salt.minion      ][INFO    ][26820] Starting a new job with PID 26820
2017-10-12 06:41:06,105 [salt.state       ][INFO    ][26820] Loading fresh modules for state activity
2017-10-12 06:41:06,128 [salt.fileclient  ][INFO    ][26820] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-12 06:41:06,148 [salt.fileclient  ][INFO    ][26820] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-12 06:41:06,418 [salt.state       ][INFO    ][26820] Running state [attr] at time 06:41:06.417872
2017-10-12 06:41:06,418 [salt.state       ][INFO    ][26820] Executing state pkg.installed for attr
2017-10-12 06:41:06,418 [salt.loaded.int.module.cmdmod][INFO    ][26820] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-12 06:41:06,742 [salt.loaded.int.module.cmdmod][INFO    ][26820] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-12 06:41:08,761 [salt.loaded.int.module.cmdmod][INFO    ][26820] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-10-12 06:41:11,207 [salt.loaded.int.module.cmdmod][INFO    ][26820] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-12 06:41:11,232 [salt.state       ][INFO    ][26820] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-10-12 06:41:11,240 [salt.state       ][INFO    ][26820] Loading fresh modules for state activity
2017-10-12 06:41:11,252 [salt.state       ][INFO    ][26820] Completed state [attr] at time 06:41:11.251870 duration_in_ms=4833.998
2017-10-12 06:41:11,257 [salt.state       ][INFO    ][26820] Running state [glusterfs-server] at time 06:41:11.256822
2017-10-12 06:41:11,257 [salt.state       ][INFO    ][26820] Executing state pkg.installed for glusterfs-server
2017-10-12 06:41:11,442 [salt.loaded.int.module.cmdmod][INFO    ][26820] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-10-12 06:41:13,703 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command saltutil.find_job with jid 20171012064113690189
2017-10-12 06:41:13,718 [salt.minion      ][INFO    ][27855] Starting a new job with PID 27855
2017-10-12 06:41:13,729 [salt.minion      ][INFO    ][27855] Returning information for job: 20171012064113690189
2017-10-12 06:41:23,903 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command saltutil.find_job with jid 20171012064123889168
2017-10-12 06:41:23,918 [salt.minion      ][INFO    ][30661] Starting a new job with PID 30661
2017-10-12 06:41:23,927 [salt.minion      ][INFO    ][30661] Returning information for job: 20171012064123889168
2017-10-12 06:41:29,118 [salt.loaded.int.module.cmdmod][INFO    ][26820] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-12 06:41:29,143 [salt.state       ][INFO    ][26820] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-10-12 06:41:29,151 [salt.state       ][INFO    ][26820] Loading fresh modules for state activity
2017-10-12 06:41:29,163 [salt.state       ][INFO    ][26820] Completed state [glusterfs-server] at time 06:41:29.163203 duration_in_ms=17906.38
2017-10-12 06:41:29,168 [salt.state       ][INFO    ][26820] Running state [bc] at time 06:41:29.167536
2017-10-12 06:41:29,168 [salt.state       ][INFO    ][26820] Executing state pkg.installed for bc
2017-10-12 06:41:29,435 [salt.loaded.int.module.cmdmod][INFO    ][26820] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-10-12 06:41:32,206 [salt.loaded.int.module.cmdmod][INFO    ][26820] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-12 06:41:32,232 [salt.state       ][INFO    ][26820] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-10-12 06:41:32,241 [salt.state       ][INFO    ][26820] Loading fresh modules for state activity
2017-10-12 06:41:32,254 [salt.state       ][INFO    ][26820] Completed state [bc] at time 06:41:32.254097 duration_in_ms=3086.559
2017-10-12 06:41:32,319 [salt.state       ][INFO    ][26820] Running state [glusterfs-server] at time 06:41:32.319082
2017-10-12 06:41:32,319 [salt.state       ][INFO    ][26820] Executing state service.running for glusterfs-server
2017-10-12 06:41:32,321 [salt.loaded.int.module.cmdmod][INFO    ][26820] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-12 06:41:32,330 [salt.loaded.int.module.cmdmod][INFO    ][26820] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-12 06:41:32,339 [salt.loaded.int.module.cmdmod][INFO    ][26820] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-12 06:41:32,349 [salt.state       ][INFO    ][26820] The service glusterfs-server is already running
2017-10-12 06:41:32,349 [salt.state       ][INFO    ][26820] Completed state [glusterfs-server] at time 06:41:32.349187 duration_in_ms=30.104
2017-10-12 06:41:32,351 [salt.state       ][INFO    ][26820] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:41:32.351341
2017-10-12 06:41:32,352 [salt.state       ][INFO    ][26820] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-12 06:41:32,362 [salt.state       ][INFO    ][26820] File changed:
New file
2017-10-12 06:41:32,363 [salt.state       ][INFO    ][26820] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:41:32.362611 duration_in_ms=11.27
2017-10-12 06:41:32,363 [salt.state       ][INFO    ][26820] Running state [/srv/glusterfs/glance] at time 06:41:32.362779
2017-10-12 06:41:32,363 [salt.state       ][INFO    ][26820] Executing state file.directory for /srv/glusterfs/glance
2017-10-12 06:41:32,364 [salt.state       ][INFO    ][26820] {'/srv/glusterfs/glance': 'New Dir'}
2017-10-12 06:41:32,364 [salt.state       ][INFO    ][26820] Completed state [/srv/glusterfs/glance] at time 06:41:32.363692 duration_in_ms=0.913
2017-10-12 06:41:32,364 [salt.state       ][INFO    ][26820] Running state [/srv/glusterfs/keystone-keys] at time 06:41:32.363844
2017-10-12 06:41:32,364 [salt.state       ][INFO    ][26820] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-12 06:41:32,364 [salt.state       ][INFO    ][26820] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-10-12 06:41:32,365 [salt.state       ][INFO    ][26820] Completed state [/srv/glusterfs/keystone-keys] at time 06:41:32.364533 duration_in_ms=0.689
2017-10-12 06:41:32,365 [salt.state       ][INFO    ][26820] Running state [/srv/glusterfs/nova_instances] at time 06:41:32.364696
2017-10-12 06:41:32,365 [salt.state       ][INFO    ][26820] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-12 06:41:32,365 [salt.state       ][INFO    ][26820] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-10-12 06:41:32,365 [salt.state       ][INFO    ][26820] Completed state [/srv/glusterfs/nova_instances] at time 06:41:32.365380 duration_in_ms=0.684
2017-10-12 06:41:32,366 [salt.state       ][INFO    ][26820] Running state [/srv/glusterfs/keystone-credential-keys] at time 06:41:32.365543
2017-10-12 06:41:32,366 [salt.state       ][INFO    ][26820] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-12 06:41:32,366 [salt.state       ][INFO    ][26820] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-10-12 06:41:32,366 [salt.state       ][INFO    ][26820] Completed state [/srv/glusterfs/keystone-credential-keys] at time 06:41:32.366239 duration_in_ms=0.696
2017-10-12 06:41:32,367 [salt.minion      ][INFO    ][26820] Returning information for job: 20171012064103597239
2017-10-12 06:41:53,412 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command test.ping with jid 20171012064153399996
2017-10-12 06:41:53,427 [salt.minion      ][INFO    ][31622] Starting a new job with PID 31622
2017-10-12 06:41:53,453 [salt.minion      ][INFO    ][31622] Returning information for job: 20171012064153399996
2017-10-12 06:41:53,585 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command state.sls with jid 20171012064153571257
2017-10-12 06:41:53,610 [salt.minion      ][INFO    ][31628] Starting a new job with PID 31628
2017-10-12 06:41:55,155 [salt.state       ][INFO    ][31628] Loading fresh modules for state activity
2017-10-12 06:41:55,178 [salt.fileclient  ][INFO    ][31628] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-12 06:41:55,211 [salt.fileclient  ][INFO    ][31628] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-12 06:41:55,275 [salt.fileclient  ][INFO    ][31628] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-12 06:41:55,294 [salt.fileclient  ][INFO    ][31628] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-12 06:41:55,563 [salt.state       ][INFO    ][31628] Running state [attr] at time 06:41:55.563313
2017-10-12 06:41:55,564 [salt.state       ][INFO    ][31628] Executing state pkg.installed for attr
2017-10-12 06:41:55,564 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-12 06:41:55,843 [salt.state       ][INFO    ][31628] Package attr is already installed
2017-10-12 06:41:55,843 [salt.state       ][INFO    ][31628] Completed state [attr] at time 06:41:55.842971 duration_in_ms=279.657
2017-10-12 06:41:55,843 [salt.state       ][INFO    ][31628] Running state [glusterfs-server] at time 06:41:55.843184
2017-10-12 06:41:55,843 [salt.state       ][INFO    ][31628] Executing state pkg.installed for glusterfs-server
2017-10-12 06:41:55,846 [salt.state       ][INFO    ][31628] Package glusterfs-server is already installed
2017-10-12 06:41:55,846 [salt.state       ][INFO    ][31628] Completed state [glusterfs-server] at time 06:41:55.846073 duration_in_ms=2.889
2017-10-12 06:41:55,846 [salt.state       ][INFO    ][31628] Running state [bc] at time 06:41:55.846224
2017-10-12 06:41:55,846 [salt.state       ][INFO    ][31628] Executing state pkg.installed for bc
2017-10-12 06:41:55,849 [salt.state       ][INFO    ][31628] Package bc is already installed
2017-10-12 06:41:55,849 [salt.state       ][INFO    ][31628] Completed state [bc] at time 06:41:55.849044 duration_in_ms=2.819
2017-10-12 06:41:55,850 [salt.state       ][INFO    ][31628] Running state [glusterfs-server] at time 06:41:55.849844
2017-10-12 06:41:55,850 [salt.state       ][INFO    ][31628] Executing state service.running for glusterfs-server
2017-10-12 06:41:55,850 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-12 06:41:55,861 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-10-12 06:41:55,902 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-12 06:41:55,919 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-12 06:41:55,927 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-12 06:41:55,937 [salt.state       ][INFO    ][31628] The service glusterfs-server is already running
2017-10-12 06:41:55,937 [salt.state       ][INFO    ][31628] Completed state [glusterfs-server] at time 06:41:55.937063 duration_in_ms=87.219
2017-10-12 06:41:55,938 [salt.state       ][INFO    ][31628] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:41:55.938436
2017-10-12 06:41:55,939 [salt.state       ][INFO    ][31628] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-12 06:41:55,943 [salt.state       ][INFO    ][31628] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-12 06:41:55,944 [salt.state       ][INFO    ][31628] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:41:55.943521 duration_in_ms=5.084
2017-10-12 06:41:55,944 [salt.state       ][INFO    ][31628] Running state [/srv/glusterfs/glance] at time 06:41:55.943689
2017-10-12 06:41:55,944 [salt.state       ][INFO    ][31628] Executing state file.directory for /srv/glusterfs/glance
2017-10-12 06:41:55,944 [salt.state       ][INFO    ][31628] Directory /srv/glusterfs/glance is in the correct state
2017-10-12 06:41:55,944 [salt.state       ][INFO    ][31628] Completed state [/srv/glusterfs/glance] at time 06:41:55.944333 duration_in_ms=0.644
2017-10-12 06:41:55,944 [salt.state       ][INFO    ][31628] Running state [/srv/glusterfs/keystone-keys] at time 06:41:55.944471
2017-10-12 06:41:55,945 [salt.state       ][INFO    ][31628] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-12 06:41:55,945 [salt.state       ][INFO    ][31628] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-12 06:41:55,945 [salt.state       ][INFO    ][31628] Completed state [/srv/glusterfs/keystone-keys] at time 06:41:55.945007 duration_in_ms=0.537
2017-10-12 06:41:55,945 [salt.state       ][INFO    ][31628] Running state [/srv/glusterfs/nova_instances] at time 06:41:55.945149
2017-10-12 06:41:55,945 [salt.state       ][INFO    ][31628] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-12 06:41:55,946 [salt.state       ][INFO    ][31628] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-12 06:41:55,946 [salt.state       ][INFO    ][31628] Completed state [/srv/glusterfs/nova_instances] at time 06:41:55.945740 duration_in_ms=0.59
2017-10-12 06:41:55,946 [salt.state       ][INFO    ][31628] Running state [/srv/glusterfs/keystone-credential-keys] at time 06:41:55.945873
2017-10-12 06:41:55,946 [salt.state       ][INFO    ][31628] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-12 06:41:55,946 [salt.state       ][INFO    ][31628] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-12 06:41:55,946 [salt.state       ][INFO    ][31628] Completed state [/srv/glusterfs/keystone-credential-keys] at time 06:41:55.946432 duration_in_ms=0.558
2017-10-12 06:41:55,993 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command ['git', '--version'] in directory '/root'
2017-10-12 06:41:56,076 [salt.state       ][INFO    ][31628] Running state [sleep 5] at time 06:41:56.076457
2017-10-12 06:41:56,077 [salt.state       ][INFO    ][31628] Executing state cmd.wait for sleep 5
2017-10-12 06:41:56,077 [salt.state       ][INFO    ][31628] No changes made for sleep 5
2017-10-12 06:41:56,077 [salt.state       ][INFO    ][31628] Completed state [sleep 5] at time 06:41:56.076996 duration_in_ms=0.539
2017-10-12 06:41:56,077 [salt.state       ][INFO    ][31628] Running state [10.167.4.141] at time 06:41:56.077377
2017-10-12 06:41:56,078 [salt.state       ][INFO    ][31628] Executing state glusterfs.peered for 10.167.4.141
2017-10-12 06:41:56,078 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:56,088 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:56,139 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:56,148 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:56,514 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:56,526 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:56,628 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:56,639 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:56,693 [salt.state       ][INFO    ][31628] {'new': {'10.167.4.141': []}, 'old': None}
2017-10-12 06:41:56,693 [salt.state       ][INFO    ][31628] Completed state [10.167.4.141] at time 06:41:56.693331 duration_in_ms=615.953
2017-10-12 06:41:56,696 [salt.state       ][INFO    ][31628] Running state [10.167.4.142] at time 06:41:56.695575
2017-10-12 06:41:56,705 [salt.state       ][INFO    ][31628] Executing state glusterfs.peered for 10.167.4.142
2017-10-12 06:41:56,706 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:56,716 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:56,815 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:56,825 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:57,141 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:57,154 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:57,260 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:57,270 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:57,322 [salt.state       ][INFO    ][31628] {'new': {'10.167.4.141': [], '10.167.4.142': []}, 'old': {'10.167.4.141': []}}
2017-10-12 06:41:57,322 [salt.state       ][INFO    ][31628] Completed state [10.167.4.142] at time 06:41:57.322241 duration_in_ms=626.666
2017-10-12 06:41:57,325 [salt.state       ][INFO    ][31628] Running state [10.167.4.143] at time 06:41:57.324601
2017-10-12 06:41:57,325 [salt.state       ][INFO    ][31628] Executing state glusterfs.peered for 10.167.4.143
2017-10-12 06:41:57,325 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:57,335 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:57,471 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:57,482 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:57,534 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:57,545 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:57,594 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:57,604 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:57,651 [salt.state       ][INFO    ][31628] Peering with localhost is not needed
2017-10-12 06:41:57,651 [salt.state       ][INFO    ][31628] Completed state [10.167.4.143] at time 06:41:57.651249 duration_in_ms=326.648
2017-10-12 06:41:57,652 [salt.state       ][INFO    ][31628] Running state [glance] at time 06:41:57.652067
2017-10-12 06:41:57,652 [salt.state       ][INFO    ][31628] Executing state glusterfs.created for glance
2017-10-12 06:41:57,653 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:57,662 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:57,709 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:57,719 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:58,468 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:58,479 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:59,506 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:41:59,519 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:41:59,573 [salt.state       ][INFO    ][31628] {'new': ['glance'], 'old': []}
2017-10-12 06:41:59,574 [salt.state       ][INFO    ][31628] Completed state [glance] at time 06:41:59.573553 duration_in_ms=1921.485
2017-10-12 06:41:59,577 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 06:41:59.576796
2017-10-12 06:41:59,577 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-12 06:41:59,578 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-12 06:41:59,633 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-12 06:42:00,307 [salt.state       ][INFO    ][31628] {'pid': 31850, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:00,307 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 06:42:00.306898 duration_in_ms=730.101
2017-10-12 06:42:00,308 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 06:42:00.307584
2017-10-12 06:42:00,308 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-12 06:42:00,309 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-12 06:42:00,365 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-10-12 06:42:01,056 [salt.state       ][INFO    ][31628] {'pid': 31868, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:01,057 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 06:42:01.056539 duration_in_ms=748.955
2017-10-12 06:42:01,057 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 06:42:01.057079
2017-10-12 06:42:01,057 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-12 06:42:01,058 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-12 06:42:01,114 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-10-12 06:42:03,630 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command saltutil.find_job with jid 20171012064203615588
2017-10-12 06:42:03,645 [salt.minion      ][INFO    ][31895] Starting a new job with PID 31895
2017-10-12 06:42:03,655 [salt.minion      ][INFO    ][31895] Returning information for job: 20171012064203615588
2017-10-12 06:42:04,061 [salt.state       ][INFO    ][31628] {'pid': 31885, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:04,061 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 06:42:04.060892 duration_in_ms=3003.812
2017-10-12 06:42:04,062 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 06:42:04.061573
2017-10-12 06:42:04,062 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-12 06:42:04,063 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-12 06:42:04,122 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-12 06:42:04,743 [salt.state       ][INFO    ][31628] {'pid': 31911, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:04,743 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 06:42:04.743061 duration_in_ms=681.488
2017-10-12 06:42:04,744 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 06:42:04.743666
2017-10-12 06:42:04,744 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-12 06:42:04,745 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-12 06:42:04,801 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-10-12 06:42:05,426 [salt.state       ][INFO    ][31628] {'pid': 31928, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:05,426 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 06:42:05.426114 duration_in_ms=682.447
2017-10-12 06:42:05,427 [salt.state       ][INFO    ][31628] Running state [glance] at time 06:42:05.427147
2017-10-12 06:42:05,427 [salt.state       ][INFO    ][31628] Executing state glusterfs.started for glance
2017-10-12 06:42:05,428 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:05,440 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:05,494 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:05,506 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:05,566 [salt.state       ][INFO    ][31628] Volume glance is already started
2017-10-12 06:42:05,567 [salt.state       ][INFO    ][31628] Completed state [glance] at time 06:42:05.566604 duration_in_ms=139.456
2017-10-12 06:42:05,568 [salt.state       ][INFO    ][31628] Running state [keystone-keys] at time 06:42:05.567879
2017-10-12 06:42:05,568 [salt.state       ][INFO    ][31628] Executing state glusterfs.created for keystone-keys
2017-10-12 06:42:05,569 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:05,580 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:05,632 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:05,642 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:06,356 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:06,369 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:09,266 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:09,277 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:09,330 [salt.state       ][INFO    ][31628] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-10-12 06:42:09,330 [salt.state       ][INFO    ][31628] Completed state [keystone-keys] at time 06:42:09.330148 duration_in_ms=3762.268
2017-10-12 06:42:09,333 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 06:42:09.333112
2017-10-12 06:42:09,333 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-12 06:42:09,334 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-12 06:42:09,386 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-10-12 06:42:10,044 [salt.state       ][INFO    ][31628] {'pid': 32039, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:10,045 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 06:42:10.044663 duration_in_ms=711.55
2017-10-12 06:42:10,045 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:42:10.045220
2017-10-12 06:42:10,046 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-12 06:42:10,046 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-12 06:42:10,101 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-12 06:42:10,769 [salt.state       ][INFO    ][31628] {'pid': 32057, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:10,769 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:42:10.769120 duration_in_ms=723.899
2017-10-12 06:42:10,770 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:42:10.769699
2017-10-12 06:42:10,770 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-12 06:42:10,771 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-12 06:42:10,825 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-12 06:42:11,489 [salt.state       ][INFO    ][31628] {'pid': 32075, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:11,490 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:42:11.489459 duration_in_ms=719.759
2017-10-12 06:42:11,490 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 06:42:11.490044
2017-10-12 06:42:11,490 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-12 06:42:11,491 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-12 06:42:11,547 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-10-12 06:42:13,766 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command saltutil.find_job with jid 20171012064213753626
2017-10-12 06:42:13,782 [salt.minion      ][INFO    ][32104] Starting a new job with PID 32104
2017-10-12 06:42:13,793 [salt.minion      ][INFO    ][32104] Returning information for job: 20171012064213753626
2017-10-12 06:42:14,262 [salt.state       ][INFO    ][31628] {'pid': 32092, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:14,262 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 06:42:14.262261 duration_in_ms=2772.217
2017-10-12 06:42:14,263 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 06:42:14.262833
2017-10-12 06:42:14,263 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-12 06:42:14,264 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-12 06:42:14,320 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-10-12 06:42:14,942 [salt.state       ][INFO    ][31628] {'pid': 32116, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:14,943 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 06:42:14.942748 duration_in_ms=679.913
2017-10-12 06:42:14,944 [salt.state       ][INFO    ][31628] Running state [keystone-keys] at time 06:42:14.943945
2017-10-12 06:42:14,944 [salt.state       ][INFO    ][31628] Executing state glusterfs.started for keystone-keys
2017-10-12 06:42:14,945 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:14,957 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:15,008 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:15,018 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:15,073 [salt.state       ][INFO    ][31628] Volume keystone-keys is already started
2017-10-12 06:42:15,073 [salt.state       ][INFO    ][31628] Completed state [keystone-keys] at time 06:42:15.073274 duration_in_ms=129.328
2017-10-12 06:42:15,074 [salt.state       ][INFO    ][31628] Running state [nova_instances] at time 06:42:15.074201
2017-10-12 06:42:15,074 [salt.state       ][INFO    ][31628] Executing state glusterfs.created for nova_instances
2017-10-12 06:42:15,075 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:15,085 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:15,134 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:15,144 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:15,872 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:15,885 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:18,767 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:18,779 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:18,831 [salt.state       ][INFO    ][31628] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-10-12 06:42:18,832 [salt.state       ][INFO    ][31628] Completed state [nova_instances] at time 06:42:18.831669 duration_in_ms=3757.467
2017-10-12 06:42:18,835 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 06:42:18.835188
2017-10-12 06:42:18,835 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-12 06:42:18,836 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-12 06:42:18,889 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-12 06:42:19,553 [salt.state       ][INFO    ][31628] {'pid': 32230, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:19,554 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 06:42:19.553563 duration_in_ms=718.374
2017-10-12 06:42:19,554 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 06:42:19.554136
2017-10-12 06:42:19,554 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-12 06:42:19,555 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-12 06:42:19,614 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'' in directory '/root'
2017-10-12 06:42:20,277 [salt.state       ][INFO    ][31628] {'pid': 32248, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:20,277 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 06:42:20.277175 duration_in_ms=723.038
2017-10-12 06:42:20,278 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 06:42:20.277766
2017-10-12 06:42:20,278 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-12 06:42:20,279 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-12 06:42:20,333 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'On'' in directory '/root'
2017-10-12 06:42:21,052 [salt.state       ][INFO    ][31628] {'pid': 32265, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:21,052 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 06:42:21.051816 duration_in_ms=774.049
2017-10-12 06:42:21,053 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 06:42:21.052674
2017-10-12 06:42:21,053 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-12 06:42:21,054 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-12 06:42:21,108 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'On'' in directory '/root'
2017-10-12 06:42:23,829 [salt.state       ][INFO    ][31628] {'pid': 32282, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:23,830 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 06:42:23.829800 duration_in_ms=2777.127
2017-10-12 06:42:23,830 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 06:42:23.830360
2017-10-12 06:42:23,831 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-12 06:42:23,831 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-12 06:42:23,890 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-12 06:42:23,909 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command saltutil.find_job with jid 20171012064223894800
2017-10-12 06:42:23,925 [salt.minion      ][INFO    ][32307] Starting a new job with PID 32307
2017-10-12 06:42:23,935 [salt.minion      ][INFO    ][32307] Returning information for job: 20171012064223894800
2017-10-12 06:42:24,540 [salt.state       ][INFO    ][31628] {'pid': 32301, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:24,540 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 06:42:24.540143 duration_in_ms=709.781
2017-10-12 06:42:24,541 [salt.state       ][INFO    ][31628] Running state [nova_instances] at time 06:42:24.541169
2017-10-12 06:42:24,541 [salt.state       ][INFO    ][31628] Executing state glusterfs.started for nova_instances
2017-10-12 06:42:24,542 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:24,554 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:24,604 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:24,614 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:24,667 [salt.state       ][INFO    ][31628] Volume nova_instances is already started
2017-10-12 06:42:24,667 [salt.state       ][INFO    ][31628] Completed state [nova_instances] at time 06:42:24.666975 duration_in_ms=125.805
2017-10-12 06:42:24,668 [salt.state       ][INFO    ][31628] Running state [keystone-credential-keys] at time 06:42:24.667961
2017-10-12 06:42:24,668 [salt.state       ][INFO    ][31628] Executing state glusterfs.created for keystone-credential-keys
2017-10-12 06:42:24,669 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:24,679 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:24,732 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:24,741 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:25,476 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:25,488 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:28,404 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:28,415 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:28,467 [salt.state       ][INFO    ][31628] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-10-12 06:42:28,467 [salt.state       ][INFO    ][31628] Completed state [keystone-credential-keys] at time 06:42:28.467067 duration_in_ms=3799.104
2017-10-12 06:42:28,470 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 06:42:28.470104
2017-10-12 06:42:28,470 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-12 06:42:28,471 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-12 06:42:28,524 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-10-12 06:42:29,207 [salt.state       ][INFO    ][31628] {'pid': 32422, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:29,207 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 06:42:29.207359 duration_in_ms=737.254
2017-10-12 06:42:29,208 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:42:29.207947
2017-10-12 06:42:29,208 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-12 06:42:29,209 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-12 06:42:29,269 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-12 06:42:29,926 [salt.state       ][INFO    ][31628] {'pid': 32439, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:29,926 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:42:29.925823 duration_in_ms=717.875
2017-10-12 06:42:29,926 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 06:42:29.926402
2017-10-12 06:42:29,927 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-12 06:42:29,927 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-12 06:42:29,980 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-10-12 06:42:32,680 [salt.state       ][INFO    ][31628] {'pid': 32458, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:32,680 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 06:42:32.680118 duration_in_ms=2753.715
2017-10-12 06:42:32,681 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:42:32.680704
2017-10-12 06:42:32,681 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-12 06:42:32,682 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-12 06:42:32,740 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-12 06:42:33,389 [salt.state       ][INFO    ][31628] {'pid': 32477, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:33,390 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:42:33.389689 duration_in_ms=708.983
2017-10-12 06:42:33,390 [salt.state       ][INFO    ][31628] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 06:42:33.390265
2017-10-12 06:42:33,391 [salt.state       ][INFO    ][31628] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-12 06:42:33,391 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-12 06:42:33,448 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-10-12 06:42:34,049 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command saltutil.find_job with jid 20171012064234035409
2017-10-12 06:42:34,065 [salt.minion      ][INFO    ][32504] Starting a new job with PID 32504
2017-10-12 06:42:34,074 [salt.state       ][INFO    ][31628] {'pid': 32494, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-12 06:42:34,075 [salt.state       ][INFO    ][31628] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 06:42:34.074484 duration_in_ms=684.219
2017-10-12 06:42:34,075 [salt.minion      ][INFO    ][32504] Returning information for job: 20171012064234035409
2017-10-12 06:42:34,076 [salt.state       ][INFO    ][31628] Running state [keystone-credential-keys] at time 06:42:34.075569
2017-10-12 06:42:34,076 [salt.state       ][INFO    ][31628] Executing state glusterfs.started for keystone-credential-keys
2017-10-12 06:42:34,076 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:34,087 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:34,138 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --version' in directory '/root'
2017-10-12 06:42:34,148 [salt.loaded.int.module.cmdmod][INFO    ][31628] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-12 06:42:34,205 [salt.state       ][INFO    ][31628] Volume keystone-credential-keys is already started
2017-10-12 06:42:34,205 [salt.state       ][INFO    ][31628] Completed state [keystone-credential-keys] at time 06:42:34.205436 duration_in_ms=129.866
2017-10-12 06:42:34,207 [salt.minion      ][INFO    ][31628] Returning information for job: 20171012064153571257
2017-10-12 06:42:44,264 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command test.ping with jid 20171012064244252113
2017-10-12 06:42:44,279 [salt.minion      ][INFO    ][32530] Starting a new job with PID 32530
2017-10-12 06:42:44,305 [salt.minion      ][INFO    ][32530] Returning information for job: 20171012064244252113
2017-10-12 06:42:44,468 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command cmd.run with jid 20171012064244453955
2017-10-12 06:42:44,482 [salt.minion      ][INFO    ][32535] Starting a new job with PID 32535
2017-10-12 06:42:44,486 [salt.loaded.int.module.cmdmod][INFO    ][32535] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-12 06:42:44,593 [salt.minion      ][INFO    ][32535] Returning information for job: 20171012064244453955
2017-10-12 07:17:17,132 [salt.utils.schedule][INFO    ][23940] Running scheduled job: __mine_interval
2017-10-12 08:03:55,325 [salt.minion      ][INFO    ][23940] User sudo_ubuntu Executing command cp.push_dir with jid 20171012080355304829
2017-10-12 08:03:55,342 [salt.minion      ][INFO    ][1121] Starting a new job with PID 1121
