2017-11-29 07:15:18,159 [salt.cli.daemons ][WARNING ][2341] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-29 07:15:30,263 [salt.state       ][ERROR   ][3569] No contents found in top file
2017-11-29 07:19:12,408 [salt.utils.parsers][WARNING ][2341] Minion received a SIGTERM. Exiting.
2017-11-29 07:21:25,011 [salt.cli.daemons ][WARNING ][3268] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-29 07:24:46,283 [py.warnings      ][WARNING ][14198] /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-11-29 07:26:13,864 [salt.loaded.int.module.cmdmod][ERROR   ][14198] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 07:26:13,865 [salt.loaded.int.module.cmdmod][ERROR   ][14198] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 07:26:20,722 [salt.loaded.int.module.cmdmod][ERROR   ][14198] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 07:26:20,723 [salt.loaded.int.module.cmdmod][ERROR   ][14198] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 07:26:32,993 [salt.loaded.int.module.cmdmod][ERROR   ][14198] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 07:26:32,993 [salt.loaded.int.module.cmdmod][ERROR   ][14198] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 07:26:42,624 [salt.loaded.int.module.cmdmod][ERROR   ][14198] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 07:26:42,624 [salt.loaded.int.module.cmdmod][ERROR   ][14198] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 07:26:52,527 [salt.loaded.int.module.cmdmod][ERROR   ][14198] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 07:26:52,528 [salt.loaded.int.module.cmdmod][ERROR   ][14198] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 07:26:59,388 [salt.loaded.int.module.cmdmod][ERROR   ][14198] 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-11-29 07:27:01,871 [salt.loaded.int.module.cmdmod][INFO    ][21661] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-29 07:27:01,878 [salt.loaded.int.module.cmdmod][INFO    ][21661] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-29 07:27:01,886 [salt.loaded.int.module.cmdmod][INFO    ][21661] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-29 07:27:01,893 [salt.utils.parsers][WARNING ][3268] Minion received a SIGTERM. Exiting.
2017-11-29 07:27:02,150 [salt.cli.daemons ][INFO    ][21739] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-11-29 07:27:02,673 [salt.minion      ][INFO    ][21739] Creating minion process manager
2017-11-29 07:27:02,673 [salt.cli.daemons ][WARNING ][21739] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-29 07:27:02,673 [salt.cli.daemons ][INFO    ][21739] The Salt Minion is starting up
2017-11-29 07:27:02,673 [salt.minion      ][INFO    ][21739] Minion is starting as user 'root'
2017-11-29 07:27:02,674 [salt.utils.event ][INFO    ][21739] Starting pull socket on /var/run/salt/minion/minion_event_4fcafbd0f5_pull.ipc
2017-11-29 07:27:03,529 [salt.loaded.int.module.cmdmod][INFO    ][21739] Executing command ['date', '+%z'] in directory '/root'
2017-11-29 07:27:03,537 [salt.utils.schedule][INFO    ][21739] Updating job settings for scheduled job: __mine_interval
2017-11-29 07:27:03,539 [salt.minion      ][INFO    ][21739] Added mine.update to scheduler
2017-11-29 07:27:03,854 [salt.minion      ][INFO    ][21739] Minion is ready to receive requests!
2017-11-29 07:27:04,855 [salt.utils.schedule][INFO    ][21739] Running scheduled job: __mine_interval
2017-11-29 07:27:25,148 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171129072725150084
2017-11-29 07:27:25,161 [salt.minion      ][INFO    ][21842] Starting a new job with PID 21842
2017-11-29 07:27:27,710 [salt.state       ][INFO    ][21842] Loading fresh modules for state activity
2017-11-29 07:27:27,733 [salt.state       ][ERROR   ][21842] No contents found in top file
2017-11-29 07:27:27,734 [salt.utils.extmods][INFO    ][21842] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-29 07:27:27,738 [salt.utils.extmods][INFO    ][21842] Syncing beacons for environment 'base'
2017-11-29 07:27:27,738 [salt.utils.extmods][INFO    ][21842] Loading cache from salt://_beacons, for base)
2017-11-29 07:27:27,738 [salt.fileclient  ][INFO    ][21842] Caching directory '_beacons/' for environment 'base'
2017-11-29 07:27:27,762 [salt.utils.extmods][INFO    ][21842] Syncing modules for environment 'base'
2017-11-29 07:27:27,762 [salt.utils.extmods][INFO    ][21842] Loading cache from salt://_modules, for base)
2017-11-29 07:27:27,762 [salt.fileclient  ][INFO    ][21842] Caching directory '_modules/' for environment 'base'
2017-11-29 07:27:27,933 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-11-29 07:27:27,946 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-29 07:27:27,956 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-29 07:27:27,966 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-29 07:27:27,975 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-29 07:27:28,011 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-29 07:27:28,023 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-29 07:27:28,034 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-29 07:27:28,045 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-29 07:27:28,056 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-29 07:27:28,154 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-29 07:27:28,277 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-29 07:27:28,288 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-29 07:27:28,298 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-29 07:27:28,309 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-29 07:27:28,319 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-29 07:27:28,332 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-29 07:27:28,385 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-29 07:27:28,420 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-29 07:27:28,434 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-29 07:27:28,446 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-29 07:27:28,457 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-29 07:27:28,500 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-29 07:27:28,515 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-29 07:27:28,526 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-29 07:27:28,540 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-29 07:27:28,551 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-29 07:27:28,562 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-29 07:27:28,573 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-29 07:27:28,591 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-29 07:27:28,601 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-29 07:27:28,612 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-29 07:27:28,623 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-29 07:27:28,636 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-29 07:27:28,639 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-29 07:27:28,639 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-11-29 07:27:28,639 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-29 07:27:28,640 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-29 07:27:28,640 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-29 07:27:28,640 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-29 07:27:28,640 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-29 07:27:28,641 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-29 07:27:28,641 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-29 07:27:28,641 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-29 07:27:28,641 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-29 07:27:28,641 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-29 07:27:28,642 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-29 07:27:28,642 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-29 07:27:28,642 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-29 07:27:28,642 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-29 07:27:28,642 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-29 07:27:28,643 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-29 07:27:28,643 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-29 07:27:28,643 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-29 07:27:28,643 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-29 07:27:28,643 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-29 07:27:28,644 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-29 07:27:28,644 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-29 07:27:28,644 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-29 07:27:28,644 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-29 07:27:28,645 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-29 07:27:28,645 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-29 07:27:28,645 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-29 07:27:28,645 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-29 07:27:28,645 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-29 07:27:28,646 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-29 07:27:28,646 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-29 07:27:28,646 [salt.utils.extmods][INFO    ][21842] 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-11-29 07:27:28,646 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-29 07:27:28,646 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-29 07:27:28,651 [salt.utils.extmods][INFO    ][21842] Syncing states for environment 'base'
2017-11-29 07:27:28,651 [salt.utils.extmods][INFO    ][21842] Loading cache from salt://_states, for base)
2017-11-29 07:27:28,651 [salt.fileclient  ][INFO    ][21842] Caching directory '_states/' for environment 'base'
2017-11-29 07:27:28,690 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-11-29 07:27:28,701 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-29 07:27:28,713 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-29 07:27:28,756 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-29 07:27:28,768 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-29 07:27:28,780 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-29 07:27:28,791 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-29 07:27:28,801 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-29 07:27:28,813 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-29 07:27:28,823 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-11-29 07:27:28,833 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-29 07:27:28,843 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-29 07:27:28,852 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-29 07:27:28,863 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-29 07:27:28,902 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-29 07:27:28,944 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-29 07:27:28,955 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-29 07:27:28,965 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-29 07:27:28,976 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-29 07:27:28,986 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-29 07:27:28,996 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-29 07:27:29,006 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-29 07:27:29,016 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-29 07:27:29,026 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-29 07:27:29,036 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-29 07:27:29,048 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-29 07:27:29,529 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-29 07:27:29,545 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-29 07:27:29,556 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-29 07:27:29,568 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-29 07:27:29,580 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-29 07:27:29,591 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-29 07:27:29,594 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-11-29 07:27:29,594 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-29 07:27:29,594 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-29 07:27:29,595 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-29 07:27:29,595 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-29 07:27:29,595 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-29 07:27:29,595 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-29 07:27:29,596 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-29 07:27:29,596 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-29 07:27:29,596 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-11-29 07:27:29,596 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-29 07:27:29,596 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-29 07:27:29,597 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-29 07:27:29,597 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-29 07:27:29,597 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-29 07:27:29,597 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-29 07:27:29,598 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-29 07:27:29,598 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-29 07:27:29,598 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-29 07:27:29,598 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-29 07:27:29,599 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-29 07:27:29,599 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-29 07:27:29,599 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-29 07:27:29,599 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-29 07:27:29,599 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-29 07:27:29,600 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-29 07:27:29,600 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-29 07:27:29,600 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-29 07:27:29,600 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-29 07:27:29,601 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-29 07:27:29,601 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-29 07:27:29,601 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-29 07:27:29,601 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-29 07:27:29,603 [salt.utils.extmods][INFO    ][21842] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-29 07:27:29,606 [salt.utils.extmods][INFO    ][21842] Syncing sdb for environment 'base'
2017-11-29 07:27:29,606 [salt.utils.extmods][INFO    ][21842] Loading cache from salt://_sdb, for base)
2017-11-29 07:27:29,607 [salt.fileclient  ][INFO    ][21842] Caching directory '_sdb/' for environment 'base'
2017-11-29 07:27:29,641 [salt.utils.extmods][INFO    ][21842] Syncing grains for environment 'base'
2017-11-29 07:27:29,642 [salt.utils.extmods][INFO    ][21842] Loading cache from salt://_grains, for base)
2017-11-29 07:27:29,642 [salt.fileclient  ][INFO    ][21842] Caching directory '_grains/' for environment 'base'
2017-11-29 07:27:29,685 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-29 07:27:29,696 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-29 07:27:29,709 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-29 07:27:29,724 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-29 07:27:29,737 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-29 07:27:29,748 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-29 07:27:29,761 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-29 07:27:29,771 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-29 07:27:29,781 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-29 07:27:29,792 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-29 07:27:29,802 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-29 07:27:29,812 [salt.fileclient  ][INFO    ][21842] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-29 07:27:29,815 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-29 07:27:29,816 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-29 07:27:29,816 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-29 07:27:29,816 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-29 07:27:29,816 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-29 07:27:29,816 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-29 07:27:29,817 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-29 07:27:29,817 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-29 07:27:29,817 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-29 07:27:29,817 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-29 07:27:29,817 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-29 07:27:29,818 [salt.utils.extmods][INFO    ][21842] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-29 07:27:29,819 [salt.utils.extmods][INFO    ][21842] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-29 07:27:29,821 [salt.utils.extmods][INFO    ][21842] Syncing renderers for environment 'base'
2017-11-29 07:27:29,821 [salt.utils.extmods][INFO    ][21842] Loading cache from salt://_renderers, for base)
2017-11-29 07:27:29,821 [salt.fileclient  ][INFO    ][21842] Caching directory '_renderers/' for environment 'base'
2017-11-29 07:27:29,853 [salt.utils.extmods][INFO    ][21842] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-29 07:27:29,855 [salt.utils.extmods][INFO    ][21842] Syncing returners for environment 'base'
2017-11-29 07:27:29,855 [salt.utils.extmods][INFO    ][21842] Loading cache from salt://_returners, for base)
2017-11-29 07:27:29,855 [salt.fileclient  ][INFO    ][21842] Caching directory '_returners/' for environment 'base'
2017-11-29 07:27:29,968 [salt.utils.extmods][INFO    ][21842] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-29 07:27:29,971 [salt.utils.extmods][INFO    ][21842] Syncing output for environment 'base'
2017-11-29 07:27:29,971 [salt.utils.extmods][INFO    ][21842] Loading cache from salt://_output, for base)
2017-11-29 07:27:29,971 [salt.fileclient  ][INFO    ][21842] Caching directory '_output/' for environment 'base'
2017-11-29 07:27:30,004 [salt.utils.extmods][INFO    ][21842] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-29 07:27:30,006 [salt.utils.extmods][INFO    ][21842] Syncing utils for environment 'base'
2017-11-29 07:27:30,006 [salt.utils.extmods][INFO    ][21842] Loading cache from salt://_utils, for base)
2017-11-29 07:27:30,006 [salt.fileclient  ][INFO    ][21842] Caching directory '_utils/' for environment 'base'
2017-11-29 07:27:30,039 [salt.utils.extmods][INFO    ][21842] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-29 07:27:30,041 [salt.utils.extmods][INFO    ][21842] Syncing log_handlers for environment 'base'
2017-11-29 07:27:30,041 [salt.utils.extmods][INFO    ][21842] Loading cache from salt://_log_handlers, for base)
2017-11-29 07:27:30,042 [salt.fileclient  ][INFO    ][21842] Caching directory '_log_handlers/' for environment 'base'
2017-11-29 07:27:30,077 [salt.utils.extmods][INFO    ][21842] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-29 07:27:30,079 [salt.utils.extmods][INFO    ][21842] Syncing proxy for environment 'base'
2017-11-29 07:27:30,080 [salt.utils.extmods][INFO    ][21842] Loading cache from salt://_proxy, for base)
2017-11-29 07:27:30,080 [salt.fileclient  ][INFO    ][21842] Caching directory '_proxy/' for environment 'base'
2017-11-29 07:27:30,111 [salt.utils.extmods][INFO    ][21842] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-29 07:27:30,114 [salt.utils.extmods][INFO    ][21842] Syncing engines for environment 'base'
2017-11-29 07:27:30,114 [salt.utils.extmods][INFO    ][21842] Loading cache from salt://_engines, for base)
2017-11-29 07:27:30,114 [salt.fileclient  ][INFO    ][21842] Caching directory '_engines/' for environment 'base'
2017-11-29 07:27:30,156 [salt.minion      ][INFO    ][21842] Returning information for job: 20171129072725150084
2017-11-29 07:27:37,668 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command state.sls with jid 20171129072737664796
2017-11-29 07:27:37,682 [salt.minion      ][INFO    ][21941] Starting a new job with PID 21941
2017-11-29 07:27:38,222 [salt.state       ][INFO    ][21941] Loading fresh modules for state activity
2017-11-29 07:27:38,247 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-29 07:27:38,264 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-29 07:27:38,331 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 07:27:38,397 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-29 07:27:38,410 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-29 07:27:38,433 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 07:27:38,546 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-29 07:27:38,566 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-29 07:27:38,638 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-29 07:27:38,655 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-29 07:27:38,728 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 07:27:38,778 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-29 07:27:38,786 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-29 07:27:38,809 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-29 07:27:38,827 [py.warnings      ][WARNING ][21941] /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-11-29 07:27:38,828 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'salt-minion --version' in directory '/root'
2017-11-29 07:27:39,077 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-29 07:27:39,156 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-29 07:27:39,275 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-29 07:27:39,289 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-29 07:27:39,323 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-29 07:27:39,338 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-29 07:27:39,359 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-11-29 07:27:39,372 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-11-29 07:27:39,388 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-29 07:27:39,495 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-29 07:27:39,553 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-29 07:27:39,574 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 07:27:39,691 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-29 07:27:39,710 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-29 07:27:39,754 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-29 07:27:39,773 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-29 07:27:39,848 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 07:27:39,865 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-29 07:27:39,871 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-29 07:27:39,893 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-29 07:27:39,908 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'salt-minion --version' in directory '/root'
2017-11-29 07:27:40,171 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-29 07:27:40,191 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-29 07:27:40,203 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-29 07:27:40,215 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-29 07:27:40,314 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-29 07:27:40,328 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-29 07:27:40,349 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-11-29 07:27:40,478 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-11-29 07:27:40,496 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-29 07:27:40,532 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-29 07:27:40,597 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-29 07:27:40,653 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 07:27:41,157 [salt.state       ][INFO    ][21941] Running state [salt-minion] at time 07:27:41.157085
2017-11-29 07:27:41,157 [salt.state       ][INFO    ][21941] Executing state pkg.installed for salt-minion
2017-11-29 07:27:41,158 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 07:27:41,436 [salt.state       ][INFO    ][21941] Package salt-minion is already installed
2017-11-29 07:27:41,436 [salt.state       ][INFO    ][21941] Completed state [salt-minion] at time 07:27:41.436196 duration_in_ms=279.11
2017-11-29 07:27:41,436 [salt.state       ][INFO    ][21941] Running state [salt_minion_dependency_packages] at time 07:27:41.436437
2017-11-29 07:27:41,437 [salt.state       ][INFO    ][21941] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-29 07:27:41,439 [salt.state       ][INFO    ][21941] All specified packages are already installed
2017-11-29 07:27:41,440 [salt.state       ][INFO    ][21941] Completed state [salt_minion_dependency_packages] at time 07:27:41.439550 duration_in_ms=3.112
2017-11-29 07:27:41,442 [salt.state       ][INFO    ][21941] Running state [/etc/salt/minion.d/minion.conf] at time 07:27:41.441766
2017-11-29 07:27:41,442 [salt.state       ][INFO    ][21941] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-29 07:27:41,467 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-29 07:27:41,515 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 07:27:41,681 [salt.fileclient  ][INFO    ][21941] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-29 07:27:41,742 [salt.state       ][INFO    ][21941] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-29 07:27:41,742 [salt.state       ][INFO    ][21941] Completed state [/etc/salt/minion.d/minion.conf] at time 07:27:41.741831 duration_in_ms=300.065
2017-11-29 07:27:41,742 [salt.state       ][INFO    ][21941] Running state [/etc/salt/minion.d/_virt.conf] at time 07:27:41.742215
2017-11-29 07:27:41,742 [salt.state       ][INFO    ][21941] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-29 07:27:41,789 [salt.state       ][INFO    ][21941] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-29 07:27:41,789 [salt.state       ][INFO    ][21941] Completed state [/etc/salt/minion.d/_virt.conf] at time 07:27:41.788990 duration_in_ms=46.775
2017-11-29 07:27:41,791 [salt.state       ][INFO    ][21941] Running state [salt-minion] at time 07:27:41.790716
2017-11-29 07:27:41,791 [salt.state       ][INFO    ][21941] Executing state service.running for salt-minion
2017-11-29 07:27:41,791 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-29 07:27:41,809 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-29 07:27:41,817 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-29 07:27:41,825 [salt.state       ][INFO    ][21941] The service salt-minion is already running
2017-11-29 07:27:41,825 [salt.state       ][INFO    ][21941] Completed state [salt-minion] at time 07:27:41.825022 duration_in_ms=34.305
2017-11-29 07:27:41,826 [salt.state       ][INFO    ][21941] Running state [/etc/salt/grains.d] at time 07:27:41.826410
2017-11-29 07:27:41,827 [salt.state       ][INFO    ][21941] Executing state file.directory for /etc/salt/grains.d
2017-11-29 07:27:41,827 [salt.state       ][INFO    ][21941] Directory /etc/salt/grains.d is in the correct state
2017-11-29 07:27:41,827 [salt.state       ][INFO    ][21941] Completed state [/etc/salt/grains.d] at time 07:27:41.827397 duration_in_ms=0.987
2017-11-29 07:27:41,828 [salt.state       ][INFO    ][21941] Running state [/etc/salt/grains] at time 07:27:41.827864
2017-11-29 07:27:41,828 [salt.state       ][INFO    ][21941] Executing state file.managed for /etc/salt/grains
2017-11-29 07:27:41,828 [salt.state       ][INFO    ][21941] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-29 07:27:41,829 [salt.state       ][INFO    ][21941] Completed state [/etc/salt/grains] at time 07:27:41.828597 duration_in_ms=0.732
2017-11-29 07:27:41,829 [salt.state       ][INFO    ][21941] Running state [/etc/salt/grains.d/placeholder] at time 07:27:41.828903
2017-11-29 07:27:41,829 [salt.state       ][INFO    ][21941] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-29 07:27:41,829 [salt.state       ][INFO    ][21941] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-29 07:27:41,830 [salt.state       ][INFO    ][21941] Completed state [/etc/salt/grains.d/placeholder] at time 07:27:41.829633 duration_in_ms=0.73
2017-11-29 07:27:41,830 [salt.state       ][INFO    ][21941] Running state [/etc/salt/grains.d/sphinx] at time 07:27:41.829936
2017-11-29 07:27:41,830 [salt.state       ][INFO    ][21941] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-29 07:27:41,873 [salt.state       ][INFO    ][21941] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.143
               - 127.0.0.1
               - 192.168.11.251
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-29 07:27:41,873 [salt.state       ][INFO    ][21941] Completed state [/etc/salt/grains.d/sphinx] at time 07:27:41.873239 duration_in_ms=43.303
2017-11-29 07:27:41,874 [salt.state       ][INFO    ][21941] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:27:41.874125
2017-11-29 07:27:41,875 [salt.state       ][INFO    ][21941] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-29 07:27:41,875 [salt.state       ][INFO    ][21941] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-29 07:27:41,875 [salt.state       ][INFO    ][21941] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:27:41.874860 duration_in_ms=0.736
2017-11-29 07:27:41,875 [salt.state       ][INFO    ][21941] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:27:41.875005
2017-11-29 07:27:41,875 [salt.state       ][INFO    ][21941] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-29 07:27:41,876 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-29 07:27:41,956 [salt.state       ][INFO    ][21941] {'pid': 21990, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-29 07:27:41,956 [salt.state       ][INFO    ][21941] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:27:41.955901 duration_in_ms=80.894
2017-11-29 07:27:41,957 [salt.state       ][INFO    ][21941] Running state [/etc/salt/grains.d/dns_records] at time 07:27:41.956587
2017-11-29 07:27:41,957 [salt.state       ][INFO    ][21941] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-29 07:27:41,977 [salt.state       ][INFO    ][21941] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-29 07:27:41,977 [salt.state       ][INFO    ][21941] Completed state [/etc/salt/grains.d/dns_records] at time 07:27:41.976885 duration_in_ms=20.298
2017-11-29 07:27:41,978 [salt.state       ][INFO    ][21941] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 07:27:41.977483
2017-11-29 07:27:41,978 [salt.state       ][INFO    ][21941] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-29 07:27:41,978 [salt.state       ][INFO    ][21941] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-29 07:27:41,978 [salt.state       ][INFO    ][21941] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 07:27:41.977946 duration_in_ms=0.463
2017-11-29 07:27:41,978 [salt.state       ][INFO    ][21941] Running state [/etc/salt/grains.d/salt] at time 07:27:41.978193
2017-11-29 07:27:41,978 [salt.state       ][INFO    ][21941] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-29 07:27:42,037 [salt.state       ][INFO    ][21941] File /etc/salt/grains.d/salt is in the correct state
2017-11-29 07:27:42,037 [salt.state       ][INFO    ][21941] Completed state [/etc/salt/grains.d/salt] at time 07:27:42.036714 duration_in_ms=58.52
2017-11-29 07:27:42,037 [salt.state       ][INFO    ][21941] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:27:42.037243
2017-11-29 07:27:42,037 [salt.state       ][INFO    ][21941] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-29 07:27:42,038 [salt.state       ][INFO    ][21941] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-29 07:27:42,038 [salt.state       ][INFO    ][21941] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:27:42.037736 duration_in_ms=0.492
2017-11-29 07:27:42,039 [salt.state       ][INFO    ][21941] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:27:42.038869
2017-11-29 07:27:42,039 [salt.state       ][INFO    ][21941] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-29 07:27:42,039 [salt.state       ][INFO    ][21941] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-29 07:27:42,039 [salt.state       ][INFO    ][21941] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:27:42.039371 duration_in_ms=0.502
2017-11-29 07:27:42,040 [salt.state       ][INFO    ][21941] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:27:42.039515
2017-11-29 07:27:42,040 [salt.state       ][INFO    ][21941] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-29 07:27:42,041 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-29 07:27:42,049 [salt.state       ][INFO    ][21941] {'pid': 21992, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-29 07:27:42,049 [salt.state       ][INFO    ][21941] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:27:42.049011 duration_in_ms=9.494
2017-11-29 07:27:42,050 [salt.state       ][INFO    ][21941] Running state [mine.update] at time 07:27:42.049621
2017-11-29 07:27:42,050 [salt.state       ][INFO    ][21941] Executing state module.wait for mine.update
2017-11-29 07:27:42,050 [salt.state       ][INFO    ][21941] No changes made for mine.update
2017-11-29 07:27:42,050 [salt.state       ][INFO    ][21941] Completed state [mine.update] at time 07:27:42.050150 duration_in_ms=0.529
2017-11-29 07:27:42,050 [salt.state       ][INFO    ][21941] Running state [mine.update] at time 07:27:42.050272
2017-11-29 07:27:42,050 [salt.state       ][INFO    ][21941] Executing state module.mod_watch for mine.update
2017-11-29 07:27:42,569 [salt.state       ][INFO    ][21941] {'ret': True}
2017-11-29 07:27:42,570 [salt.state       ][INFO    ][21941] Completed state [mine.update] at time 07:27:42.569847 duration_in_ms=519.574
2017-11-29 07:27:42,570 [salt.state       ][INFO    ][21941] Running state [ca-certificates] at time 07:27:42.570113
2017-11-29 07:27:42,570 [salt.state       ][INFO    ][21941] Executing state pkg.installed for ca-certificates
2017-11-29 07:27:42,574 [salt.state       ][INFO    ][21941] Package ca-certificates is already installed
2017-11-29 07:27:42,574 [salt.state       ][INFO    ][21941] Completed state [ca-certificates] at time 07:27:42.573766 duration_in_ms=3.653
2017-11-29 07:27:42,574 [salt.state       ][INFO    ][21941] Running state [update-ca-certificates] at time 07:27:42.574356
2017-11-29 07:27:42,575 [salt.state       ][INFO    ][21941] Executing state cmd.wait for update-ca-certificates
2017-11-29 07:27:42,575 [salt.state       ][INFO    ][21941] No changes made for update-ca-certificates
2017-11-29 07:27:42,575 [salt.state       ][INFO    ][21941] Completed state [update-ca-certificates] at time 07:27:42.574959 duration_in_ms=0.602
2017-11-29 07:27:42,575 [salt.state       ][INFO    ][21941] Running state [libvirt-dev] at time 07:27:42.575144
2017-11-29 07:27:42,575 [salt.state       ][INFO    ][21941] Executing state pkg.installed for libvirt-dev
2017-11-29 07:27:42,578 [salt.state       ][INFO    ][21941] Package libvirt-dev is already installed
2017-11-29 07:27:42,578 [salt.state       ][INFO    ][21941] Completed state [libvirt-dev] at time 07:27:42.578231 duration_in_ms=3.087
2017-11-29 07:27:42,578 [salt.state       ][INFO    ][21941] Running state [pkg-config] at time 07:27:42.578426
2017-11-29 07:27:42,579 [salt.state       ][INFO    ][21941] Executing state pkg.installed for pkg-config
2017-11-29 07:27:42,581 [salt.state       ][INFO    ][21941] Package pkg-config is already installed
2017-11-29 07:27:42,582 [salt.state       ][INFO    ][21941] Completed state [pkg-config] at time 07:27:42.581503 duration_in_ms=3.077
2017-11-29 07:27:42,582 [salt.state       ][INFO    ][21941] Running state [virtng.init] at time 07:27:42.581684
2017-11-29 07:27:42,582 [salt.state       ][INFO    ][21941] Executing state module.run for virtng.init
2017-11-29 07:27:42,699 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command ['git', '--version'] in directory '/root'
2017-11-29 07:27:42,745 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-29 07:27:42,842 [salt.state       ][INFO    ][21941] unless execution succeeded
2017-11-29 07:27:42,842 [salt.state       ][INFO    ][21941] Completed state [virtng.init] at time 07:27:42.841747 duration_in_ms=260.062
2017-11-29 07:27:42,842 [salt.state       ][INFO    ][21941] Running state [virt.set_autostart] at time 07:27:42.842028
2017-11-29 07:27:42,842 [salt.state       ][INFO    ][21941] Executing state module.run for virt.set_autostart
2017-11-29 07:27:42,844 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-29 07:27:42,861 [salt.state       ][INFO    ][21941] unless execution succeeded
2017-11-29 07:27:42,904 [salt.state       ][INFO    ][21941] Completed state [virt.set_autostart] at time 07:27:42.903781 duration_in_ms=61.742
2017-11-29 07:27:42,904 [salt.state       ][INFO    ][21941] Running state [virtng.init] at time 07:27:42.904106
2017-11-29 07:27:42,904 [salt.state       ][INFO    ][21941] Executing state module.run for virtng.init
2017-11-29 07:27:42,906 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-29 07:27:42,926 [salt.state       ][INFO    ][21941] unless execution succeeded
2017-11-29 07:27:42,926 [salt.state       ][INFO    ][21941] Completed state [virtng.init] at time 07:27:42.925915 duration_in_ms=21.809
2017-11-29 07:27:42,926 [salt.state       ][INFO    ][21941] Running state [virt.set_autostart] at time 07:27:42.926213
2017-11-29 07:27:42,926 [salt.state       ][INFO    ][21941] Executing state module.run for virt.set_autostart
2017-11-29 07:27:42,929 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-29 07:27:42,945 [salt.state       ][INFO    ][21941] unless execution succeeded
2017-11-29 07:27:42,945 [salt.state       ][INFO    ][21941] Completed state [virt.set_autostart] at time 07:27:42.945052 duration_in_ms=18.839
2017-11-29 07:27:42,945 [salt.state       ][INFO    ][21941] Running state [virtng.init] at time 07:27:42.945325
2017-11-29 07:27:42,946 [salt.state       ][INFO    ][21941] Executing state module.run for virtng.init
2017-11-29 07:27:42,948 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-29 07:27:42,963 [salt.state       ][INFO    ][21941] unless execution succeeded
2017-11-29 07:27:42,964 [salt.state       ][INFO    ][21941] Completed state [virtng.init] at time 07:27:42.963631 duration_in_ms=18.306
2017-11-29 07:27:42,964 [salt.state       ][INFO    ][21941] Running state [virt.set_autostart] at time 07:27:42.963884
2017-11-29 07:27:42,964 [salt.state       ][INFO    ][21941] Executing state module.run for virt.set_autostart
2017-11-29 07:27:42,966 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-29 07:27:42,983 [salt.state       ][INFO    ][21941] unless execution succeeded
2017-11-29 07:27:42,983 [salt.state       ][INFO    ][21941] Completed state [virt.set_autostart] at time 07:27:42.982823 duration_in_ms=18.939
2017-11-29 07:27:42,983 [salt.state       ][INFO    ][21941] Running state [virtng.init] at time 07:27:42.983056
2017-11-29 07:27:42,983 [salt.state       ][INFO    ][21941] Executing state module.run for virtng.init
2017-11-29 07:27:42,985 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-29 07:27:42,999 [salt.state       ][INFO    ][21941] unless execution succeeded
2017-11-29 07:27:42,1000 [salt.state       ][INFO    ][21941] Completed state [virtng.init] at time 07:27:42.999614 duration_in_ms=16.558
2017-11-29 07:27:42,1000 [salt.state       ][INFO    ][21941] Running state [virt.set_autostart] at time 07:27:42.999864
2017-11-29 07:27:43,000 [salt.state       ][INFO    ][21941] Executing state module.run for virt.set_autostart
2017-11-29 07:27:43,002 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-29 07:27:43,017 [salt.state       ][INFO    ][21941] unless execution succeeded
2017-11-29 07:27:43,017 [salt.state       ][INFO    ][21941] Completed state [virt.set_autostart] at time 07:27:43.017092 duration_in_ms=17.228
2017-11-29 07:27:43,017 [salt.state       ][INFO    ][21941] Running state [virtng.init] at time 07:27:43.017328
2017-11-29 07:27:43,018 [salt.state       ][INFO    ][21941] Executing state module.run for virtng.init
2017-11-29 07:27:43,019 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-29 07:27:43,035 [salt.state       ][INFO    ][21941] unless execution succeeded
2017-11-29 07:27:43,035 [salt.state       ][INFO    ][21941] Completed state [virtng.init] at time 07:27:43.034989 duration_in_ms=17.661
2017-11-29 07:27:43,035 [salt.state       ][INFO    ][21941] Running state [virt.set_autostart] at time 07:27:43.035201
2017-11-29 07:27:43,035 [salt.state       ][INFO    ][21941] Executing state module.run for virt.set_autostart
2017-11-29 07:27:43,037 [salt.loaded.int.module.cmdmod][INFO    ][21941] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-11-29 07:27:43,052 [salt.state       ][INFO    ][21941] unless execution succeeded
2017-11-29 07:27:43,052 [salt.state       ][INFO    ][21941] Completed state [virt.set_autostart] at time 07:27:43.052316 duration_in_ms=17.115
2017-11-29 07:27:43,055 [salt.minion      ][INFO    ][21941] Returning information for job: 20171129072737664796
2017-11-29 07:28:51,676 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171129072851670171
2017-11-29 07:28:51,691 [salt.minion      ][INFO    ][22058] Starting a new job with PID 22058
2017-11-29 07:28:55,219 [salt.state       ][INFO    ][22058] Loading fresh modules for state activity
2017-11-29 07:28:55,250 [salt.state       ][ERROR   ][22058] No contents found in top file
2017-11-29 07:28:55,251 [salt.utils.extmods][INFO    ][22058] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-29 07:28:55,254 [salt.utils.extmods][INFO    ][22058] Syncing beacons for environment 'base'
2017-11-29 07:28:55,254 [salt.utils.extmods][INFO    ][22058] Loading cache from salt://_beacons, for base)
2017-11-29 07:28:55,254 [salt.fileclient  ][INFO    ][22058] Caching directory '_beacons/' for environment 'base'
2017-11-29 07:28:55,285 [salt.utils.extmods][INFO    ][22058] Syncing modules for environment 'base'
2017-11-29 07:28:55,285 [salt.utils.extmods][INFO    ][22058] Loading cache from salt://_modules, for base)
2017-11-29 07:28:55,286 [salt.fileclient  ][INFO    ][22058] Caching directory '_modules/' for environment 'base'
2017-11-29 07:28:55,542 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-11-29 07:28:55,552 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-29 07:28:55,573 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-29 07:28:55,587 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-29 07:28:55,619 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-29 07:28:55,644 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-29 07:28:55,722 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-29 07:28:55,754 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-29 07:28:55,788 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-29 07:28:55,814 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-29 07:28:55,833 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-29 07:28:55,867 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-29 07:28:55,888 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-29 07:28:55,921 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-29 07:28:55,944 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-29 07:28:55,980 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-29 07:28:56,005 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-29 07:28:56,055 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-29 07:28:56,082 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-29 07:28:56,173 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-29 07:28:56,239 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-29 07:28:56,254 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-29 07:28:56,272 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-29 07:28:56,298 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-29 07:28:56,325 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-29 07:28:56,380 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-29 07:28:56,427 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-29 07:28:56,451 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-29 07:28:56,469 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-29 07:28:56,512 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-29 07:28:56,530 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-29 07:28:56,573 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-29 07:28:56,607 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-29 07:28:56,626 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-29 07:28:56,629 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-29 07:28:56,629 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-11-29 07:28:56,630 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-29 07:28:56,630 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-29 07:28:56,630 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-29 07:28:56,631 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-29 07:28:56,631 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-29 07:28:56,631 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-29 07:28:56,631 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-29 07:28:56,632 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-29 07:28:56,632 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-29 07:28:56,632 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-29 07:28:56,632 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-29 07:28:56,633 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-29 07:28:56,633 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-29 07:28:56,633 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-29 07:28:56,634 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-29 07:28:56,634 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-29 07:28:56,634 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-29 07:28:56,634 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-29 07:28:56,634 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-29 07:28:56,635 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-29 07:28:56,635 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-29 07:28:56,635 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-29 07:28:56,635 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-29 07:28:56,636 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-29 07:28:56,636 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-29 07:28:56,636 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-29 07:28:56,636 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-29 07:28:56,637 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-29 07:28:56,637 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-29 07:28:56,637 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-29 07:28:56,637 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-29 07:28:56,638 [salt.utils.extmods][INFO    ][22058] 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-11-29 07:28:56,638 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-29 07:28:56,638 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-29 07:28:56,643 [salt.utils.extmods][INFO    ][22058] Syncing states for environment 'base'
2017-11-29 07:28:56,644 [salt.utils.extmods][INFO    ][22058] Loading cache from salt://_states, for base)
2017-11-29 07:28:56,644 [salt.fileclient  ][INFO    ][22058] Caching directory '_states/' for environment 'base'
2017-11-29 07:28:56,686 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-11-29 07:28:56,741 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-29 07:28:56,811 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-29 07:28:56,823 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-29 07:28:56,832 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-29 07:28:56,839 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-29 07:28:56,849 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-29 07:28:56,860 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-29 07:28:56,875 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-29 07:28:56,916 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-11-29 07:28:56,924 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-29 07:28:56,951 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-29 07:28:56,964 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-29 07:28:57,008 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-29 07:28:57,018 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-29 07:28:57,037 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-29 07:28:57,060 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-29 07:28:57,090 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-29 07:28:57,098 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-29 07:28:57,126 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-29 07:28:57,156 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-29 07:28:57,181 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-29 07:28:57,210 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-29 07:28:57,225 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-29 07:28:57,235 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-29 07:28:57,248 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-29 07:28:57,291 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-29 07:28:57,344 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-29 07:28:57,691 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-29 07:28:57,715 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-29 07:28:58,188 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-29 07:28:58,197 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-29 07:28:58,201 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-11-29 07:28:58,202 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-29 07:28:58,202 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-29 07:28:58,202 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-29 07:28:58,202 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-29 07:28:58,203 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-29 07:28:58,203 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-29 07:28:58,203 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-29 07:28:58,203 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-29 07:28:58,204 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-11-29 07:28:58,204 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-29 07:28:58,204 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-29 07:28:58,204 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-29 07:28:58,205 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-29 07:28:58,205 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-29 07:28:58,205 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-29 07:28:58,206 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-29 07:28:58,206 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-29 07:28:58,206 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-29 07:28:58,206 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-29 07:28:58,206 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-29 07:28:58,207 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-29 07:28:58,207 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-29 07:28:58,207 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-29 07:28:58,207 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-29 07:28:58,207 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-29 07:28:58,208 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-29 07:28:58,208 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-29 07:28:58,208 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-29 07:28:58,208 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-29 07:28:58,208 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-29 07:28:58,209 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-29 07:28:58,209 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-29 07:28:58,211 [salt.utils.extmods][INFO    ][22058] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-29 07:28:58,214 [salt.utils.extmods][INFO    ][22058] Syncing sdb for environment 'base'
2017-11-29 07:28:58,214 [salt.utils.extmods][INFO    ][22058] Loading cache from salt://_sdb, for base)
2017-11-29 07:28:58,214 [salt.fileclient  ][INFO    ][22058] Caching directory '_sdb/' for environment 'base'
2017-11-29 07:28:58,236 [salt.utils.extmods][INFO    ][22058] Syncing grains for environment 'base'
2017-11-29 07:28:58,236 [salt.utils.extmods][INFO    ][22058] Loading cache from salt://_grains, for base)
2017-11-29 07:28:58,236 [salt.fileclient  ][INFO    ][22058] Caching directory '_grains/' for environment 'base'
2017-11-29 07:28:58,835 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-29 07:28:58,846 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-29 07:28:58,861 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-29 07:28:58,869 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-29 07:28:58,876 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-29 07:28:58,885 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-29 07:28:58,891 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-29 07:28:58,899 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-29 07:28:58,904 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-29 07:28:58,910 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-29 07:28:58,922 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-29 07:28:58,928 [salt.fileclient  ][INFO    ][22058] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-29 07:28:58,931 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-29 07:28:58,931 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-29 07:28:58,932 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-29 07:28:58,932 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-29 07:28:58,932 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-29 07:28:58,932 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-29 07:28:58,932 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-29 07:28:58,933 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-29 07:28:58,933 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-29 07:28:58,933 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-29 07:28:58,933 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-29 07:28:58,933 [salt.utils.extmods][INFO    ][22058] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-29 07:28:58,935 [salt.utils.extmods][INFO    ][22058] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-29 07:28:58,937 [salt.utils.extmods][INFO    ][22058] Syncing renderers for environment 'base'
2017-11-29 07:28:58,937 [salt.utils.extmods][INFO    ][22058] Loading cache from salt://_renderers, for base)
2017-11-29 07:28:58,937 [salt.fileclient  ][INFO    ][22058] Caching directory '_renderers/' for environment 'base'
2017-11-29 07:28:58,960 [salt.utils.extmods][INFO    ][22058] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-29 07:28:58,963 [salt.utils.extmods][INFO    ][22058] Syncing returners for environment 'base'
2017-11-29 07:28:58,963 [salt.utils.extmods][INFO    ][22058] Loading cache from salt://_returners, for base)
2017-11-29 07:28:58,963 [salt.fileclient  ][INFO    ][22058] Caching directory '_returners/' for environment 'base'
2017-11-29 07:28:58,981 [salt.utils.extmods][INFO    ][22058] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-29 07:28:58,983 [salt.utils.extmods][INFO    ][22058] Syncing output for environment 'base'
2017-11-29 07:28:58,983 [salt.utils.extmods][INFO    ][22058] Loading cache from salt://_output, for base)
2017-11-29 07:28:58,983 [salt.fileclient  ][INFO    ][22058] Caching directory '_output/' for environment 'base'
2017-11-29 07:28:59,006 [salt.utils.extmods][INFO    ][22058] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-29 07:28:59,009 [salt.utils.extmods][INFO    ][22058] Syncing utils for environment 'base'
2017-11-29 07:28:59,009 [salt.utils.extmods][INFO    ][22058] Loading cache from salt://_utils, for base)
2017-11-29 07:28:59,009 [salt.fileclient  ][INFO    ][22058] Caching directory '_utils/' for environment 'base'
2017-11-29 07:28:59,033 [salt.utils.extmods][INFO    ][22058] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-29 07:28:59,035 [salt.utils.extmods][INFO    ][22058] Syncing log_handlers for environment 'base'
2017-11-29 07:28:59,035 [salt.utils.extmods][INFO    ][22058] Loading cache from salt://_log_handlers, for base)
2017-11-29 07:28:59,035 [salt.fileclient  ][INFO    ][22058] Caching directory '_log_handlers/' for environment 'base'
2017-11-29 07:28:59,053 [salt.utils.extmods][INFO    ][22058] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-29 07:28:59,055 [salt.utils.extmods][INFO    ][22058] Syncing proxy for environment 'base'
2017-11-29 07:28:59,055 [salt.utils.extmods][INFO    ][22058] Loading cache from salt://_proxy, for base)
2017-11-29 07:28:59,055 [salt.fileclient  ][INFO    ][22058] Caching directory '_proxy/' for environment 'base'
2017-11-29 07:28:59,074 [salt.utils.extmods][INFO    ][22058] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-29 07:28:59,076 [salt.utils.extmods][INFO    ][22058] Syncing engines for environment 'base'
2017-11-29 07:28:59,077 [salt.utils.extmods][INFO    ][22058] Loading cache from salt://_engines, for base)
2017-11-29 07:28:59,077 [salt.fileclient  ][INFO    ][22058] Caching directory '_engines/' for environment 'base'
2017-11-29 07:28:59,100 [salt.minion      ][INFO    ][22058] Returning information for job: 20171129072851670171
2017-11-29 07:38:31,525 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command test.ping with jid 20171129073831520045
2017-11-29 07:38:31,542 [salt.minion      ][INFO    ][22281] Starting a new job with PID 22281
2017-11-29 07:38:31,582 [salt.minion      ][INFO    ][22281] Returning information for job: 20171129073831520045
2017-11-29 07:41:41,056 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command state.sls with jid 20171129074141046593
2017-11-29 07:41:41,070 [salt.minion      ][INFO    ][22325] Starting a new job with PID 22325
2017-11-29 07:41:42,773 [salt.state       ][INFO    ][22325] Loading fresh modules for state activity
2017-11-29 07:41:42,799 [salt.fileclient  ][INFO    ][22325] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-29 07:41:42,818 [salt.fileclient  ][INFO    ][22325] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-29 07:41:42,843 [salt.fileclient  ][INFO    ][22325] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 07:41:43,139 [salt.state       ][INFO    ][22325] Running state [lsof] at time 07:41:43.139068
2017-11-29 07:41:43,139 [salt.state       ][INFO    ][22325] Executing state pkg.installed for lsof
2017-11-29 07:41:43,140 [salt.loaded.int.module.cmdmod][INFO    ][22325] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 07:41:43,397 [salt.state       ][INFO    ][22325] Package lsof is already installed
2017-11-29 07:41:43,397 [salt.state       ][INFO    ][22325] Completed state [lsof] at time 07:41:43.397153 duration_in_ms=258.084
2017-11-29 07:41:43,397 [salt.state       ][INFO    ][22325] Running state [keepalived] at time 07:41:43.397365
2017-11-29 07:41:43,398 [salt.state       ][INFO    ][22325] Executing state pkg.installed for keepalived
2017-11-29 07:41:43,413 [salt.loaded.int.module.cmdmod][INFO    ][22325] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-29 07:41:45,636 [salt.loaded.int.module.cmdmod][INFO    ][22325] 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-11-29 07:41:51,102 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command saltutil.find_job with jid 20171129074151092381
2017-11-29 07:41:51,115 [salt.minion      ][INFO    ][23474] Starting a new job with PID 23474
2017-11-29 07:41:51,132 [salt.minion      ][INFO    ][23474] Returning information for job: 20171129074151092381
2017-11-29 07:41:54,418 [salt.loaded.int.module.cmdmod][INFO    ][22325] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 07:41:54,442 [salt.state       ][INFO    ][22325] 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-11-29 07:41:54,450 [salt.state       ][INFO    ][22325] Loading fresh modules for state activity
2017-11-29 07:41:54,462 [salt.state       ][INFO    ][22325] Completed state [keepalived] at time 07:41:54.461794 duration_in_ms=11064.428
2017-11-29 07:41:54,465 [salt.state       ][INFO    ][22325] Running state [/etc/keepalived/keepalived.conf] at time 07:41:54.464533
2017-11-29 07:41:54,465 [salt.state       ][INFO    ][22325] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-29 07:41:54,494 [salt.fileclient  ][INFO    ][22325] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-29 07:41:54,526 [salt.fileclient  ][INFO    ][22325] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 07:41:54,533 [salt.state       ][INFO    ][22325] File changed:
New file
2017-11-29 07:41:54,533 [salt.state       ][INFO    ][22325] Completed state [/etc/keepalived/keepalived.conf] at time 07:41:54.532969 duration_in_ms=68.435
2017-11-29 07:41:54,591 [salt.state       ][INFO    ][22325] Running state [keepalived] at time 07:41:54.591014
2017-11-29 07:41:54,591 [salt.state       ][INFO    ][22325] Executing state service.running for keepalived
2017-11-29 07:41:54,593 [salt.loaded.int.module.cmdmod][INFO    ][22325] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-29 07:41:54,601 [salt.loaded.int.module.cmdmod][INFO    ][22325] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-29 07:41:54,609 [salt.loaded.int.module.cmdmod][INFO    ][22325] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-29 07:41:54,616 [salt.loaded.int.module.cmdmod][INFO    ][22325] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-29 07:41:54,623 [salt.loaded.int.module.cmdmod][INFO    ][22325] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-29 07:41:54,686 [salt.loaded.int.module.cmdmod][INFO    ][22325] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-29 07:41:54,695 [salt.loaded.int.module.cmdmod][INFO    ][22325] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-29 07:41:54,703 [salt.loaded.int.module.cmdmod][INFO    ][22325] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-29 07:41:54,708 [salt.state       ][INFO    ][22325] {'keepalived': True}
2017-11-29 07:41:54,709 [salt.state       ][INFO    ][22325] Completed state [keepalived] at time 07:41:54.708635 duration_in_ms=117.622
2017-11-29 07:41:54,709 [salt.minion      ][INFO    ][22325] Returning information for job: 20171129074141046593
2017-11-29 07:44:34,364 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command pillar.get with jid 20171129074434359414
2017-11-29 07:44:34,383 [salt.minion      ][INFO    ][23829] Starting a new job with PID 23829
2017-11-29 07:44:34,392 [salt.minion      ][INFO    ][23829] Returning information for job: 20171129074434359414
2017-11-29 07:49:47,298 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command state.sls with jid 20171129074947295831
2017-11-29 07:49:47,314 [salt.minion      ][INFO    ][23909] Starting a new job with PID 23909
2017-11-29 07:49:48,940 [salt.state       ][INFO    ][23909] Loading fresh modules for state activity
2017-11-29 07:49:48,966 [salt.fileclient  ][INFO    ][23909] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-29 07:49:48,990 [salt.fileclient  ][INFO    ][23909] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-29 07:49:49,272 [salt.state       ][INFO    ][23909] Running state [attr] at time 07:49:49.271672
2017-11-29 07:49:49,272 [salt.state       ][INFO    ][23909] Executing state pkg.installed for attr
2017-11-29 07:49:49,272 [salt.loaded.int.module.cmdmod][INFO    ][23909] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 07:49:49,534 [salt.loaded.int.module.cmdmod][INFO    ][23909] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-29 07:49:51,022 [salt.loaded.int.module.cmdmod][INFO    ][23909] 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-11-29 07:49:53,875 [salt.loaded.int.module.cmdmod][INFO    ][23909] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 07:49:53,899 [salt.state       ][INFO    ][23909] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-29 07:49:53,907 [salt.state       ][INFO    ][23909] Loading fresh modules for state activity
2017-11-29 07:49:53,919 [salt.state       ][INFO    ][23909] Completed state [attr] at time 07:49:53.919157 duration_in_ms=4647.485
2017-11-29 07:49:53,924 [salt.state       ][INFO    ][23909] Running state [glusterfs-server] at time 07:49:53.923835
2017-11-29 07:49:53,924 [salt.state       ][INFO    ][23909] Executing state pkg.installed for glusterfs-server
2017-11-29 07:49:54,121 [salt.loaded.int.module.cmdmod][INFO    ][23909] 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-11-29 07:49:57,390 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command saltutil.find_job with jid 20171129074957381002
2017-11-29 07:49:57,403 [salt.minion      ][INFO    ][24776] Starting a new job with PID 24776
2017-11-29 07:49:57,416 [salt.minion      ][INFO    ][24776] Returning information for job: 20171129074957381002
2017-11-29 07:50:07,608 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command saltutil.find_job with jid 20171129075007588757
2017-11-29 07:50:07,622 [salt.minion      ][INFO    ][24784] Starting a new job with PID 24784
2017-11-29 07:50:07,635 [salt.minion      ][INFO    ][24784] Returning information for job: 20171129075007588757
2017-11-29 07:50:17,817 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command saltutil.find_job with jid 20171129075017808249
2017-11-29 07:50:17,828 [salt.minion      ][INFO    ][25672] Starting a new job with PID 25672
2017-11-29 07:50:17,856 [salt.minion      ][INFO    ][25672] Returning information for job: 20171129075017808249
2017-11-29 07:50:26,038 [salt.loaded.int.module.cmdmod][INFO    ][23909] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 07:50:26,062 [salt.state       ][INFO    ][23909] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'glusterfs-client' changed from 'absent' to '3.10.7-ubuntu1~xenial1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.2'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'glusterfs-common' changed from 'absent' to '3.10.7-ubuntu1~xenial1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'portmap' changed from 'absent' to '1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'
'nfs-client' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.10.7-ubuntu1~xenial1'

2017-11-29 07:50:26,069 [salt.state       ][INFO    ][23909] Loading fresh modules for state activity
2017-11-29 07:50:26,081 [salt.state       ][INFO    ][23909] Completed state [glusterfs-server] at time 07:50:26.080790 duration_in_ms=32156.954
2017-11-29 07:50:26,085 [salt.state       ][INFO    ][23909] Running state [bc] at time 07:50:26.085116
2017-11-29 07:50:26,085 [salt.state       ][INFO    ][23909] Executing state pkg.installed for bc
2017-11-29 07:50:26,345 [salt.loaded.int.module.cmdmod][INFO    ][23909] 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-11-29 07:50:27,907 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command saltutil.find_job with jid 20171129075027885313
2017-11-29 07:50:27,920 [salt.minion      ][INFO    ][26596] Starting a new job with PID 26596
2017-11-29 07:50:27,934 [salt.minion      ][INFO    ][26596] Returning information for job: 20171129075027885313
2017-11-29 07:50:29,186 [salt.loaded.int.module.cmdmod][INFO    ][23909] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 07:50:29,212 [salt.state       ][INFO    ][23909] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-29 07:50:29,220 [salt.state       ][INFO    ][23909] Loading fresh modules for state activity
2017-11-29 07:50:29,233 [salt.state       ][INFO    ][23909] Completed state [bc] at time 07:50:29.232881 duration_in_ms=3147.765
2017-11-29 07:50:29,307 [salt.state       ][INFO    ][23909] Running state [glusterfs-server] at time 07:50:29.307126
2017-11-29 07:50:29,307 [salt.state       ][INFO    ][23909] Executing state service.running for glusterfs-server
2017-11-29 07:50:29,309 [salt.loaded.int.module.cmdmod][INFO    ][23909] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-29 07:50:29,318 [salt.loaded.int.module.cmdmod][INFO    ][23909] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-29 07:50:29,325 [salt.loaded.int.module.cmdmod][INFO    ][23909] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-29 07:50:29,334 [salt.state       ][INFO    ][23909] The service glusterfs-server is already running
2017-11-29 07:50:29,334 [salt.state       ][INFO    ][23909] Completed state [glusterfs-server] at time 07:50:29.334087 duration_in_ms=26.96
2017-11-29 07:50:29,336 [salt.state       ][INFO    ][23909] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 07:50:29.335637
2017-11-29 07:50:29,336 [salt.state       ][INFO    ][23909] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-29 07:50:29,351 [salt.state       ][INFO    ][23909] File changed:
New file
2017-11-29 07:50:29,351 [salt.state       ][INFO    ][23909] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 07:50:29.351160 duration_in_ms=15.524
2017-11-29 07:50:29,351 [salt.state       ][INFO    ][23909] Running state [/srv/glusterfs/glance] at time 07:50:29.351309
2017-11-29 07:50:29,351 [salt.state       ][INFO    ][23909] Executing state file.directory for /srv/glusterfs/glance
2017-11-29 07:50:29,352 [salt.state       ][INFO    ][23909] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-29 07:50:29,352 [salt.state       ][INFO    ][23909] Completed state [/srv/glusterfs/glance] at time 07:50:29.352111 duration_in_ms=0.802
2017-11-29 07:50:29,352 [salt.state       ][INFO    ][23909] Running state [/srv/glusterfs/keystone-keys] at time 07:50:29.352254
2017-11-29 07:50:29,352 [salt.state       ][INFO    ][23909] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-29 07:50:29,353 [salt.state       ][INFO    ][23909] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-29 07:50:29,353 [salt.state       ][INFO    ][23909] Completed state [/srv/glusterfs/keystone-keys] at time 07:50:29.352871 duration_in_ms=0.618
2017-11-29 07:50:29,353 [salt.state       ][INFO    ][23909] Running state [/srv/glusterfs/nova_instances] at time 07:50:29.353012
2017-11-29 07:50:29,353 [salt.state       ][INFO    ][23909] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-29 07:50:29,354 [salt.state       ][INFO    ][23909] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-29 07:50:29,354 [salt.state       ][INFO    ][23909] Completed state [/srv/glusterfs/nova_instances] at time 07:50:29.353648 duration_in_ms=0.636
2017-11-29 07:50:29,354 [salt.state       ][INFO    ][23909] Running state [/srv/glusterfs/keystone-credential-keys] at time 07:50:29.353794
2017-11-29 07:50:29,354 [salt.state       ][INFO    ][23909] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-29 07:50:29,354 [salt.state       ][INFO    ][23909] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-29 07:50:29,354 [salt.state       ][INFO    ][23909] Completed state [/srv/glusterfs/keystone-credential-keys] at time 07:50:29.354412 duration_in_ms=0.618
2017-11-29 07:50:29,355 [salt.minion      ][INFO    ][23909] Returning information for job: 20171129074947295831
2017-11-29 07:50:30,595 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command test.ping with jid 20171129075030592790
2017-11-29 07:50:30,608 [salt.minion      ][INFO    ][26740] Starting a new job with PID 26740
2017-11-29 07:50:30,634 [salt.minion      ][INFO    ][26740] Returning information for job: 20171129075030592790
2017-11-29 07:50:30,766 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command state.sls with jid 20171129075030758382
2017-11-29 07:50:30,778 [salt.minion      ][INFO    ][26745] Starting a new job with PID 26745
2017-11-29 07:50:32,434 [salt.state       ][INFO    ][26745] Loading fresh modules for state activity
2017-11-29 07:50:32,455 [salt.fileclient  ][INFO    ][26745] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-29 07:50:32,489 [salt.fileclient  ][INFO    ][26745] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-29 07:50:32,559 [salt.fileclient  ][INFO    ][26745] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-29 07:50:32,578 [salt.fileclient  ][INFO    ][26745] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-29 07:50:32,842 [salt.state       ][INFO    ][26745] Running state [attr] at time 07:50:32.842253
2017-11-29 07:50:32,843 [salt.state       ][INFO    ][26745] Executing state pkg.installed for attr
2017-11-29 07:50:32,843 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 07:50:33,130 [salt.state       ][INFO    ][26745] Package attr is already installed
2017-11-29 07:50:33,130 [salt.state       ][INFO    ][26745] Completed state [attr] at time 07:50:33.130020 duration_in_ms=287.767
2017-11-29 07:50:33,130 [salt.state       ][INFO    ][26745] Running state [glusterfs-server] at time 07:50:33.130249
2017-11-29 07:50:33,130 [salt.state       ][INFO    ][26745] Executing state pkg.installed for glusterfs-server
2017-11-29 07:50:33,133 [salt.state       ][INFO    ][26745] Package glusterfs-server is already installed
2017-11-29 07:50:33,133 [salt.state       ][INFO    ][26745] Completed state [glusterfs-server] at time 07:50:33.133149 duration_in_ms=2.9
2017-11-29 07:50:33,133 [salt.state       ][INFO    ][26745] Running state [bc] at time 07:50:33.133305
2017-11-29 07:50:33,133 [salt.state       ][INFO    ][26745] Executing state pkg.installed for bc
2017-11-29 07:50:33,136 [salt.state       ][INFO    ][26745] Package bc is already installed
2017-11-29 07:50:33,136 [salt.state       ][INFO    ][26745] Completed state [bc] at time 07:50:33.136123 duration_in_ms=2.818
2017-11-29 07:50:33,137 [salt.state       ][INFO    ][26745] Running state [glusterfs-server] at time 07:50:33.136935
2017-11-29 07:50:33,137 [salt.state       ][INFO    ][26745] Executing state service.running for glusterfs-server
2017-11-29 07:50:33,138 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-29 07:50:33,148 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-29 07:50:33,189 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-29 07:50:33,202 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-29 07:50:33,210 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-29 07:50:33,219 [salt.state       ][INFO    ][26745] The service glusterfs-server is already running
2017-11-29 07:50:33,219 [salt.state       ][INFO    ][26745] Completed state [glusterfs-server] at time 07:50:33.218938 duration_in_ms=82.002
2017-11-29 07:50:33,220 [salt.state       ][INFO    ][26745] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 07:50:33.220363
2017-11-29 07:50:33,221 [salt.state       ][INFO    ][26745] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-29 07:50:33,231 [salt.state       ][INFO    ][26745] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-29 07:50:33,231 [salt.state       ][INFO    ][26745] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 07:50:33.230877 duration_in_ms=10.514
2017-11-29 07:50:33,231 [salt.state       ][INFO    ][26745] Running state [/srv/glusterfs/glance] at time 07:50:33.231025
2017-11-29 07:50:33,231 [salt.state       ][INFO    ][26745] Executing state file.directory for /srv/glusterfs/glance
2017-11-29 07:50:33,232 [salt.state       ][INFO    ][26745] Directory /srv/glusterfs/glance is in the correct state
2017-11-29 07:50:33,232 [salt.state       ][INFO    ][26745] Completed state [/srv/glusterfs/glance] at time 07:50:33.231625 duration_in_ms=0.601
2017-11-29 07:50:33,232 [salt.state       ][INFO    ][26745] Running state [/srv/glusterfs/keystone-keys] at time 07:50:33.231782
2017-11-29 07:50:33,232 [salt.state       ][INFO    ][26745] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-29 07:50:33,232 [salt.state       ][INFO    ][26745] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-29 07:50:33,232 [salt.state       ][INFO    ][26745] Completed state [/srv/glusterfs/keystone-keys] at time 07:50:33.232337 duration_in_ms=0.555
2017-11-29 07:50:33,232 [salt.state       ][INFO    ][26745] Running state [/srv/glusterfs/nova_instances] at time 07:50:33.232475
2017-11-29 07:50:33,233 [salt.state       ][INFO    ][26745] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-29 07:50:33,233 [salt.state       ][INFO    ][26745] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-29 07:50:33,233 [salt.state       ][INFO    ][26745] Completed state [/srv/glusterfs/nova_instances] at time 07:50:33.233014 duration_in_ms=0.538
2017-11-29 07:50:33,233 [salt.state       ][INFO    ][26745] Running state [/srv/glusterfs/keystone-credential-keys] at time 07:50:33.233154
2017-11-29 07:50:33,233 [salt.state       ][INFO    ][26745] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-29 07:50:33,234 [salt.state       ][INFO    ][26745] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-29 07:50:33,234 [salt.state       ][INFO    ][26745] Completed state [/srv/glusterfs/keystone-credential-keys] at time 07:50:33.233695 duration_in_ms=0.541
2017-11-29 07:50:33,332 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command ['git', '--version'] in directory '/root'
2017-11-29 07:50:33,373 [salt.state       ][INFO    ][26745] Running state [sleep 5] at time 07:50:33.373352
2017-11-29 07:50:33,374 [salt.state       ][INFO    ][26745] Executing state cmd.wait for sleep 5
2017-11-29 07:50:33,374 [salt.state       ][INFO    ][26745] No changes made for sleep 5
2017-11-29 07:50:33,374 [salt.state       ][INFO    ][26745] Completed state [sleep 5] at time 07:50:33.373933 duration_in_ms=0.583
2017-11-29 07:50:33,374 [salt.state       ][INFO    ][26745] Running state [10.167.4.141] at time 07:50:33.374341
2017-11-29 07:50:33,375 [salt.state       ][INFO    ][26745] Executing state glusterfs.peered for 10.167.4.141
2017-11-29 07:50:33,375 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:33,385 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:33,440 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:33,448 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:33,812 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:33,823 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:33,926 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:33,937 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:33,991 [salt.state       ][INFO    ][26745] {'new': {'10.167.4.141': []}, 'old': None}
2017-11-29 07:50:33,997 [salt.state       ][INFO    ][26745] Completed state [10.167.4.141] at time 07:50:33.996583 duration_in_ms=622.242
2017-11-29 07:50:33,999 [salt.state       ][INFO    ][26745] Running state [10.167.4.142] at time 07:50:33.999054
2017-11-29 07:50:33,999 [salt.state       ][INFO    ][26745] Executing state glusterfs.peered for 10.167.4.142
2017-11-29 07:50:33,1000 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:34,010 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:34,120 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:34,131 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:34,509 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:34,519 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:34,584 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:34,594 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:34,654 [salt.state       ][INFO    ][26745] {'new': {'10.167.4.141': [], '10.167.4.142': []}, 'old': {'10.167.4.141': []}}
2017-11-29 07:50:34,654 [salt.state       ][INFO    ][26745] Completed state [10.167.4.142] at time 07:50:34.654285 duration_in_ms=655.23
2017-11-29 07:50:34,657 [salt.state       ][INFO    ][26745] Running state [10.167.4.143] at time 07:50:34.656611
2017-11-29 07:50:34,657 [salt.state       ][INFO    ][26745] Executing state glusterfs.peered for 10.167.4.143
2017-11-29 07:50:34,657 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:34,668 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:34,830 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:34,841 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:34,902 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:34,913 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:34,971 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:34,980 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:35,035 [salt.state       ][INFO    ][26745] Peering with localhost is not needed
2017-11-29 07:50:35,035 [salt.state       ][INFO    ][26745] Completed state [10.167.4.143] at time 07:50:35.035013 duration_in_ms=378.402
2017-11-29 07:50:35,036 [salt.state       ][INFO    ][26745] Running state [glance] at time 07:50:35.035899
2017-11-29 07:50:35,036 [salt.state       ][INFO    ][26745] Executing state glusterfs.created for glance
2017-11-29 07:50:35,037 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:35,045 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:35,098 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:35,107 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:35,920 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:35,932 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:38,776 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:38,788 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:38,844 [salt.state       ][INFO    ][26745] {'new': ['glance'], 'old': []}
2017-11-29 07:50:38,844 [salt.state       ][INFO    ][26745] Completed state [glance] at time 07:50:38.844360 duration_in_ms=3808.461
2017-11-29 07:50:38,848 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 07:50:38.847637
2017-11-29 07:50:38,848 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-29 07:50:38,848 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-29 07:50:38,904 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-29 07:50:39,797 [salt.state       ][INFO    ][26745] {'pid': 27009, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:39,798 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 07:50:39.797746 duration_in_ms=950.107
2017-11-29 07:50:39,798 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 07:50:39.798328
2017-11-29 07:50:39,799 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-29 07:50:39,799 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-29 07:50:39,860 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-11-29 07:50:40,529 [salt.state       ][INFO    ][26745] {'pid': 27048, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:40,529 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 07:50:40.528918 duration_in_ms=730.589
2017-11-29 07:50:40,530 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 07:50:40.529506
2017-11-29 07:50:40,530 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-29 07:50:40,530 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-29 07:50:40,593 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-11-29 07:50:40,808 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command saltutil.find_job with jid 20171129075040799328
2017-11-29 07:50:40,822 [salt.minion      ][INFO    ][27098] Starting a new job with PID 27098
2017-11-29 07:50:40,855 [salt.minion      ][INFO    ][27098] Returning information for job: 20171129075040799328
2017-11-29 07:50:41,248 [salt.state       ][INFO    ][26745] {'pid': 27086, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:41,248 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 07:50:41.248384 duration_in_ms=718.877
2017-11-29 07:50:41,249 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 07:50:41.248973
2017-11-29 07:50:41,249 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-11-29 07:50:41,250 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-29 07:50:41,310 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-11-29 07:50:41,923 [salt.state       ][INFO    ][26745] {'pid': 27128, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:41,924 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 07:50:41.923751 duration_in_ms=674.777
2017-11-29 07:50:41,924 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 07:50:41.924339
2017-11-29 07:50:41,925 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-29 07:50:41,925 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-29 07:50:41,988 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-29 07:50:42,668 [salt.state       ][INFO    ][26745] {'pid': 27167, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:42,669 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 07:50:42.668503 duration_in_ms=744.163
2017-11-29 07:50:42,669 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 07:50:42.669092
2017-11-29 07:50:42,669 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-29 07:50:42,670 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-29 07:50:42,732 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-29 07:50:43,403 [salt.state       ][INFO    ][26745] {'pid': 27204, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:43,403 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 07:50:43.403181 duration_in_ms=734.087
2017-11-29 07:50:43,407 [salt.state       ][INFO    ][26745] Running state [glance] at time 07:50:43.407064
2017-11-29 07:50:43,409 [salt.state       ][INFO    ][26745] Executing state glusterfs.started for glance
2017-11-29 07:50:43,410 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:43,423 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:43,484 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:43,495 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:43,556 [salt.state       ][INFO    ][26745] Volume glance is already started
2017-11-29 07:50:43,557 [salt.state       ][INFO    ][26745] Completed state [glance] at time 07:50:43.556689 duration_in_ms=149.628
2017-11-29 07:50:43,558 [salt.state       ][INFO    ][26745] Running state [keystone-keys] at time 07:50:43.557862
2017-11-29 07:50:43,558 [salt.state       ][INFO    ][26745] Executing state glusterfs.created for keystone-keys
2017-11-29 07:50:43,559 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:43,570 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:43,625 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:43,635 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:44,445 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:44,456 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:47,172 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:47,184 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:47,241 [salt.state       ][INFO    ][26745] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-11-29 07:50:47,241 [salt.state       ][INFO    ][26745] Completed state [keystone-keys] at time 07:50:47.240912 duration_in_ms=3683.05
2017-11-29 07:50:47,245 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 07:50:47.245238
2017-11-29 07:50:47,246 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-29 07:50:47,246 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-29 07:50:47,302 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-29 07:50:47,960 [salt.state       ][INFO    ][26745] {'pid': 27356, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:47,961 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 07:50:47.960728 duration_in_ms=715.488
2017-11-29 07:50:47,961 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 07:50:47.961428
2017-11-29 07:50:47,962 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-29 07:50:47,962 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-29 07:50:48,025 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-29 07:50:48,682 [salt.state       ][INFO    ][26745] {'pid': 27393, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:48,682 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 07:50:48.682391 duration_in_ms=720.963
2017-11-29 07:50:48,683 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 07:50:48.682998
2017-11-29 07:50:48,683 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-29 07:50:48,684 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-29 07:50:48,743 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-11-29 07:50:49,540 [salt.state       ][INFO    ][26745] {'pid': 27433, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:49,540 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 07:50:49.540084 duration_in_ms=857.085
2017-11-29 07:50:49,541 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 07:50:49.540679
2017-11-29 07:50:49,541 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-29 07:50:49,542 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-29 07:50:49,604 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-29 07:50:50,290 [salt.state       ][INFO    ][26745] {'pid': 27470, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:50,290 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 07:50:50.290002 duration_in_ms=749.321
2017-11-29 07:50:50,291 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 07:50:50.290610
2017-11-29 07:50:50,291 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-29 07:50:50,292 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-29 07:50:50,352 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-29 07:50:50,969 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command saltutil.find_job with jid 20171129075050960988
2017-11-29 07:50:50,983 [salt.minion      ][INFO    ][27537] Starting a new job with PID 27537
2017-11-29 07:50:50,996 [salt.minion      ][INFO    ][27537] Returning information for job: 20171129075050960988
2017-11-29 07:50:51,018 [salt.state       ][INFO    ][26745] {'pid': 27509, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:51,019 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 07:50:51.018700 duration_in_ms=728.088
2017-11-29 07:50:51,019 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 07:50:51.019258
2017-11-29 07:50:51,020 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-29 07:50:51,020 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-29 07:50:51,080 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-29 07:50:51,769 [salt.state       ][INFO    ][26745] {'pid': 27551, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:51,769 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 07:50:51.769135 duration_in_ms=749.876
2017-11-29 07:50:51,770 [salt.state       ][INFO    ][26745] Running state [keystone-keys] at time 07:50:51.770372
2017-11-29 07:50:51,771 [salt.state       ][INFO    ][26745] Executing state glusterfs.started for keystone-keys
2017-11-29 07:50:51,771 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:51,783 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:51,841 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:51,851 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:51,909 [salt.state       ][INFO    ][26745] Volume keystone-keys is already started
2017-11-29 07:50:51,909 [salt.state       ][INFO    ][26745] Completed state [keystone-keys] at time 07:50:51.909180 duration_in_ms=138.808
2017-11-29 07:50:51,910 [salt.state       ][INFO    ][26745] Running state [nova_instances] at time 07:50:51.910079
2017-11-29 07:50:51,910 [salt.state       ][INFO    ][26745] Executing state glusterfs.created for nova_instances
2017-11-29 07:50:51,911 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:51,921 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:51,974 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:51,983 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:52,766 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:52,779 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:55,510 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:55,522 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:50:55,577 [salt.state       ][INFO    ][26745] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-11-29 07:50:55,578 [salt.state       ][INFO    ][26745] Completed state [nova_instances] at time 07:50:55.577783 duration_in_ms=3667.704
2017-11-29 07:50:55,581 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 07:50:55.581320
2017-11-29 07:50:55,582 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-29 07:50:55,582 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-29 07:50:55,639 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-29 07:50:56,287 [salt.state       ][INFO    ][26745] {'pid': 27715, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:56,288 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 07:50:56.287692 duration_in_ms=706.371
2017-11-29 07:50:56,288 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 07:50:56.288298
2017-11-29 07:50:56,289 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-11-29 07:50:56,289 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-29 07:50:56,348 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-29 07:50:56,989 [salt.state       ][INFO    ][26745] {'pid': 27754, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:56,990 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 07:50:56.989587 duration_in_ms=701.288
2017-11-29 07:50:56,990 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 07:50:56.990327
2017-11-29 07:50:56,991 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-11-29 07:50:56,991 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-29 07:50:57,053 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'True'' in directory '/root'
2017-11-29 07:50:57,738 [salt.state       ][INFO    ][26745] {'pid': 27791, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:57,738 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 07:50:57.738219 duration_in_ms=747.892
2017-11-29 07:50:57,739 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 07:50:57.738815
2017-11-29 07:50:57,739 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-11-29 07:50:57,740 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-29 07:50:57,802 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-11-29 07:50:58,481 [salt.state       ][INFO    ][26745] {'pid': 27828, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:58,481 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 07:50:58.481349 duration_in_ms=742.533
2017-11-29 07:50:58,482 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 07:50:58.481929
2017-11-29 07:50:58,482 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-11-29 07:50:58,483 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-11-29 07:50:58,542 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'True'' in directory '/root'
2017-11-29 07:50:59,212 [salt.state       ][INFO    ][26745] {'pid': 27868, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:59,213 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 07:50:59.212597 duration_in_ms=730.666
2017-11-29 07:50:59,213 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 07:50:59.213184
2017-11-29 07:50:59,213 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-29 07:50:59,214 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-29 07:50:59,274 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-29 07:50:59,928 [salt.state       ][INFO    ][26745] {'pid': 27905, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:50:59,929 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 07:50:59.928511 duration_in_ms=715.326
2017-11-29 07:50:59,930 [salt.state       ][INFO    ][26745] Running state [nova_instances] at time 07:50:59.929689
2017-11-29 07:50:59,930 [salt.state       ][INFO    ][26745] Executing state glusterfs.started for nova_instances
2017-11-29 07:50:59,931 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:50:59,942 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:51:00,001 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:51:00,011 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:51:00,073 [salt.state       ][INFO    ][26745] Volume nova_instances is already started
2017-11-29 07:51:00,073 [salt.state       ][INFO    ][26745] Completed state [nova_instances] at time 07:51:00.072844 duration_in_ms=143.155
2017-11-29 07:51:00,074 [salt.state       ][INFO    ][26745] Running state [keystone-credential-keys] at time 07:51:00.073784
2017-11-29 07:51:00,074 [salt.state       ][INFO    ][26745] Executing state glusterfs.created for keystone-credential-keys
2017-11-29 07:51:00,074 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:51:00,085 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:51:00,143 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:51:00,152 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:51:00,939 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:51:00,952 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:51:01,112 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command saltutil.find_job with jid 20171129075101103707
2017-11-29 07:51:01,127 [salt.minion      ][INFO    ][28004] Starting a new job with PID 28004
2017-11-29 07:51:01,141 [salt.minion      ][INFO    ][28004] Returning information for job: 20171129075101103707
2017-11-29 07:51:03,667 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:51:03,678 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:51:03,734 [salt.state       ][INFO    ][26745] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-11-29 07:51:03,734 [salt.state       ][INFO    ][26745] Completed state [keystone-credential-keys] at time 07:51:03.733848 duration_in_ms=3660.063
2017-11-29 07:51:03,738 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 07:51:03.737571
2017-11-29 07:51:03,738 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-29 07:51:03,738 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-29 07:51:03,795 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-29 07:51:04,479 [salt.state       ][INFO    ][26745] {'pid': 28070, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:51:04,480 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 07:51:04.479518 duration_in_ms=741.94
2017-11-29 07:51:04,480 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 07:51:04.480131
2017-11-29 07:51:04,480 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-29 07:51:04,481 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-29 07:51:04,542 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-11-29 07:51:05,249 [salt.state       ][INFO    ][26745] {'pid': 28107, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:51:05,249 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 07:51:05.249144 duration_in_ms=769.013
2017-11-29 07:51:05,250 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 07:51:05.249718
2017-11-29 07:51:05,250 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-29 07:51:05,251 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-29 07:51:05,313 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-29 07:51:06,008 [salt.state       ][INFO    ][26745] {'pid': 28144, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:51:06,008 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 07:51:06.007891 duration_in_ms=758.172
2017-11-29 07:51:06,009 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 07:51:06.008584
2017-11-29 07:51:06,009 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-29 07:51:06,010 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-29 07:51:06,073 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-29 07:51:06,806 [salt.state       ][INFO    ][26745] {'pid': 28183, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:51:06,806 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 07:51:06.806232 duration_in_ms=797.647
2017-11-29 07:51:06,807 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 07:51:06.806977
2017-11-29 07:51:06,807 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-29 07:51:06,808 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-29 07:51:06,869 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-29 07:51:07,557 [salt.state       ][INFO    ][26745] {'pid': 28223, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:51:07,557 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 07:51:07.557294 duration_in_ms=750.317
2017-11-29 07:51:07,558 [salt.state       ][INFO    ][26745] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 07:51:07.557911
2017-11-29 07:51:07,558 [salt.state       ][INFO    ][26745] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-29 07:51:07,559 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-29 07:51:07,623 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-29 07:51:08,288 [salt.state       ][INFO    ][26745] {'pid': 28260, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-29 07:51:08,289 [salt.state       ][INFO    ][26745] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 07:51:08.288481 duration_in_ms=730.569
2017-11-29 07:51:08,290 [salt.state       ][INFO    ][26745] Running state [keystone-credential-keys] at time 07:51:08.289713
2017-11-29 07:51:08,290 [salt.state       ][INFO    ][26745] Executing state glusterfs.started for keystone-credential-keys
2017-11-29 07:51:08,291 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:51:08,303 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:51:08,363 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --version' in directory '/root'
2017-11-29 07:51:08,373 [salt.loaded.int.module.cmdmod][INFO    ][26745] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 07:51:08,435 [salt.state       ][INFO    ][26745] Volume keystone-credential-keys is already started
2017-11-29 07:51:08,435 [salt.state       ][INFO    ][26745] Completed state [keystone-credential-keys] at time 07:51:08.435172 duration_in_ms=145.457
2017-11-29 07:51:08,438 [salt.minion      ][INFO    ][26745] Returning information for job: 20171129075030758382
2017-11-29 07:51:19,555 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command test.ping with jid 20171129075119550110
2017-11-29 07:51:19,569 [salt.minion      ][INFO    ][28314] Starting a new job with PID 28314
2017-11-29 07:51:19,596 [salt.minion      ][INFO    ][28314] Returning information for job: 20171129075119550110
2017-11-29 07:51:19,730 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command cmd.run with jid 20171129075119722992
2017-11-29 07:51:19,742 [salt.minion      ][INFO    ][28319] Starting a new job with PID 28319
2017-11-29 07:51:19,746 [salt.loaded.int.module.cmdmod][INFO    ][28319] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-29 07:51:19,866 [salt.minion      ][INFO    ][28319] Returning information for job: 20171129075119722992
2017-11-29 08:27:04,855 [salt.utils.schedule][INFO    ][21739] Running scheduled job: __mine_interval
2017-11-29 09:22:50,378 [salt.minion      ][INFO    ][21739] User sudo_ubuntu Executing command cp.push_dir with jid 20171129092250368041
2017-11-29 09:22:50,398 [salt.minion      ][INFO    ][29467] Starting a new job with PID 29467
