2017-09-19 06:13:01,793 [salt.cli.daemons ][WARNING ][2496] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-19 06:13:08,372 [salt.state       ][ERROR   ][3648] No contents found in top file
2017-09-19 06:13:27,576 [salt.utils.parsers][WARNING ][2496] Minion received a SIGTERM. Exiting.
2017-09-19 06:15:54,250 [salt.cli.daemons ][WARNING ][3229] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-19 06:20:38,627 [py.warnings      ][WARNING ][16324] /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-09-19 06:21:27,801 [salt.loaded.int.module.cmdmod][ERROR   ][16324] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-19 06:21:27,801 [salt.loaded.int.module.cmdmod][ERROR   ][16324] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-19 06:21:33,960 [salt.loaded.int.module.cmdmod][ERROR   ][16324] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-19 06:21:33,961 [salt.loaded.int.module.cmdmod][ERROR   ][16324] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-19 06:21:41,787 [salt.loaded.int.module.cmdmod][ERROR   ][16324] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-19 06:21:41,787 [salt.loaded.int.module.cmdmod][ERROR   ][16324] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-19 06:21:53,633 [salt.loaded.int.module.cmdmod][ERROR   ][16324] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-19 06:21:53,633 [salt.loaded.int.module.cmdmod][ERROR   ][16324] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-19 06:22:00,955 [salt.loaded.int.module.cmdmod][ERROR   ][16324] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-19 06:22:00,955 [salt.loaded.int.module.cmdmod][ERROR   ][16324] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-19 06:22:07,169 [salt.loaded.int.module.cmdmod][ERROR   ][16324] 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-09-19 06:22:09,219 [salt.loaded.int.module.cmdmod][INFO    ][23932] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-19 06:22:09,226 [salt.loaded.int.module.cmdmod][INFO    ][23932] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-19 06:22:09,237 [salt.loaded.int.module.cmdmod][INFO    ][23932] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-19 06:22:09,244 [salt.utils.parsers][WARNING ][3229] Minion received a SIGTERM. Exiting.
2017-09-19 06:22:09,495 [salt.cli.daemons ][INFO    ][24007] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-09-19 06:22:09,993 [salt.minion      ][INFO    ][24007] Creating minion process manager
2017-09-19 06:22:09,993 [salt.cli.daemons ][WARNING ][24007] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-19 06:22:09,993 [salt.cli.daemons ][INFO    ][24007] The Salt Minion is starting up
2017-09-19 06:22:09,993 [salt.minion      ][INFO    ][24007] Minion is starting as user 'root'
2017-09-19 06:22:09,994 [salt.utils.event ][INFO    ][24007] Starting pull socket on /var/run/salt/minion/minion_event_0031115955_pull.ipc
2017-09-19 06:22:10,810 [salt.loaded.int.module.cmdmod][INFO    ][24007] Executing command ['date', '+%z'] in directory '/root'
2017-09-19 06:22:10,818 [salt.utils.schedule][INFO    ][24007] Updating job settings for scheduled job: __mine_interval
2017-09-19 06:22:10,821 [salt.minion      ][INFO    ][24007] Added mine.update to scheduler
2017-09-19 06:22:10,980 [salt.minion      ][INFO    ][24007] Minion is ready to receive requests!
2017-09-19 06:22:11,981 [salt.utils.schedule][INFO    ][24007] Running scheduled job: __mine_interval
2017-09-19 06:22:20,766 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170919062220775748
2017-09-19 06:22:20,779 [salt.minion      ][INFO    ][24110] Starting a new job with PID 24110
2017-09-19 06:22:22,287 [salt.state       ][INFO    ][24110] Loading fresh modules for state activity
2017-09-19 06:22:22,314 [salt.state       ][ERROR   ][24110] No contents found in top file
2017-09-19 06:22:22,316 [salt.utils.extmods][INFO    ][24110] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-19 06:22:22,318 [salt.utils.extmods][INFO    ][24110] Syncing beacons for environment 'base'
2017-09-19 06:22:22,318 [salt.utils.extmods][INFO    ][24110] Loading cache from salt://_beacons, for base)
2017-09-19 06:22:22,318 [salt.fileclient  ][INFO    ][24110] Caching directory '_beacons/' for environment 'base'
2017-09-19 06:22:22,345 [salt.utils.extmods][INFO    ][24110] Syncing modules for environment 'base'
2017-09-19 06:22:22,345 [salt.utils.extmods][INFO    ][24110] Loading cache from salt://_modules, for base)
2017-09-19 06:22:22,345 [salt.fileclient  ][INFO    ][24110] Caching directory '_modules/' for environment 'base'
2017-09-19 06:22:22,377 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-19 06:22:22,387 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-19 06:22:22,412 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-19 06:22:22,420 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-19 06:22:22,428 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-19 06:22:22,444 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-19 06:22:22,453 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-19 06:22:22,463 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-19 06:22:22,473 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-19 06:22:22,483 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-19 06:22:22,508 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-19 06:22:22,518 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-19 06:22:22,527 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-19 06:22:22,538 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-19 06:22:22,574 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-19 06:22:22,596 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-19 06:22:22,608 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-19 06:22:22,619 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-19 06:22:22,630 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-19 06:22:22,655 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-19 06:22:22,670 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-19 06:22:22,703 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-19 06:22:22,715 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-19 06:22:22,742 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-19 06:22:22,757 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-19 06:22:22,767 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-19 06:22:22,778 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-19 06:22:22,795 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-19 06:22:22,811 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-19 06:22:22,821 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-19 06:22:22,831 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-19 06:22:22,844 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-19 06:22:22,847 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-19 06:22:22,847 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-19 06:22:22,848 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-19 06:22:22,848 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-19 06:22:22,848 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-19 06:22:22,848 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-19 06:22:22,849 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-19 06:22:22,849 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-19 06:22:22,849 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-19 06:22:22,849 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-19 06:22:22,850 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-19 06:22:22,850 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-19 06:22:22,850 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-19 06:22:22,850 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-19 06:22:22,851 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-19 06:22:22,851 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-19 06:22:22,874 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-19 06:22:22,875 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-19 06:22:22,875 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-19 06:22:22,875 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-19 06:22:22,876 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-19 06:22:22,876 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-19 06:22:22,876 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-19 06:22:22,877 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-19 06:22:22,877 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-19 06:22:22,877 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-19 06:22:22,877 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-19 06:22:22,878 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-19 06:22:22,878 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-19 06:22:22,878 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-19 06:22:22,878 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-19 06:22:22,879 [salt.utils.extmods][INFO    ][24110] 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-09-19 06:22:22,879 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-19 06:22:22,879 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-19 06:22:22,884 [salt.utils.extmods][INFO    ][24110] Syncing states for environment 'base'
2017-09-19 06:22:22,884 [salt.utils.extmods][INFO    ][24110] Loading cache from salt://_states, for base)
2017-09-19 06:22:22,884 [salt.fileclient  ][INFO    ][24110] Caching directory '_states/' for environment 'base'
2017-09-19 06:22:22,924 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-19 06:22:22,937 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-19 06:22:22,959 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-19 06:22:22,971 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-19 06:22:22,983 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-19 06:22:22,997 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-19 06:22:23,011 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-19 06:22:23,046 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-19 06:22:23,055 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-19 06:22:23,066 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-19 06:22:23,086 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-19 06:22:23,097 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-19 06:22:23,110 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-19 06:22:23,121 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-19 06:22:23,131 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-19 06:22:23,145 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-19 06:22:23,163 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-19 06:22:23,173 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-19 06:22:23,183 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-19 06:22:23,221 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-19 06:22:23,231 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-19 06:22:23,241 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-19 06:22:23,252 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-19 06:22:23,278 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-19 06:22:23,287 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-19 06:22:23,325 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-19 06:22:23,337 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-19 06:22:23,347 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-19 06:22:23,602 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-19 06:22:23,605 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-19 06:22:23,605 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-19 06:22:23,605 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-19 06:22:23,606 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-19 06:22:23,606 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-19 06:22:23,606 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-19 06:22:23,607 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-19 06:22:23,607 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-19 06:22:23,607 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-19 06:22:23,607 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-19 06:22:23,608 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-19 06:22:23,608 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-19 06:22:23,608 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-19 06:22:23,608 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-19 06:22:23,609 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-19 06:22:23,609 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-19 06:22:23,609 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-19 06:22:23,610 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-19 06:22:23,610 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-19 06:22:23,610 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-19 06:22:23,610 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-19 06:22:23,611 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-19 06:22:23,611 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-19 06:22:23,611 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-19 06:22:23,611 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-19 06:22:23,612 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-19 06:22:23,612 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-19 06:22:23,612 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-19 06:22:23,613 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-19 06:22:23,613 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-19 06:22:23,615 [salt.utils.extmods][INFO    ][24110] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-19 06:22:23,618 [salt.utils.extmods][INFO    ][24110] Syncing sdb for environment 'base'
2017-09-19 06:22:23,618 [salt.utils.extmods][INFO    ][24110] Loading cache from salt://_sdb, for base)
2017-09-19 06:22:23,618 [salt.fileclient  ][INFO    ][24110] Caching directory '_sdb/' for environment 'base'
2017-09-19 06:22:23,650 [salt.utils.extmods][INFO    ][24110] Syncing grains for environment 'base'
2017-09-19 06:22:23,650 [salt.utils.extmods][INFO    ][24110] Loading cache from salt://_grains, for base)
2017-09-19 06:22:23,650 [salt.fileclient  ][INFO    ][24110] Caching directory '_grains/' for environment 'base'
2017-09-19 06:22:23,688 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-19 06:22:23,730 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-19 06:22:23,741 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-19 06:22:23,753 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-19 06:22:23,775 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-19 06:22:23,788 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-19 06:22:23,800 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-19 06:22:23,811 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-19 06:22:23,823 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-19 06:22:23,835 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-19 06:22:23,845 [salt.fileclient  ][INFO    ][24110] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-19 06:22:23,847 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-19 06:22:23,848 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-19 06:22:23,848 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-19 06:22:23,848 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-19 06:22:23,848 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-19 06:22:23,849 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-19 06:22:23,849 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-19 06:22:23,849 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-19 06:22:23,849 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-19 06:22:23,850 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-19 06:22:23,850 [salt.utils.extmods][INFO    ][24110] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-19 06:22:23,851 [salt.utils.extmods][INFO    ][24110] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-19 06:22:23,853 [salt.utils.extmods][INFO    ][24110] Syncing renderers for environment 'base'
2017-09-19 06:22:23,853 [salt.utils.extmods][INFO    ][24110] Loading cache from salt://_renderers, for base)
2017-09-19 06:22:23,854 [salt.fileclient  ][INFO    ][24110] Caching directory '_renderers/' for environment 'base'
2017-09-19 06:22:23,885 [salt.utils.extmods][INFO    ][24110] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-19 06:22:23,887 [salt.utils.extmods][INFO    ][24110] Syncing returners for environment 'base'
2017-09-19 06:22:23,887 [salt.utils.extmods][INFO    ][24110] Loading cache from salt://_returners, for base)
2017-09-19 06:22:23,887 [salt.fileclient  ][INFO    ][24110] Caching directory '_returners/' for environment 'base'
2017-09-19 06:22:23,933 [salt.utils.extmods][INFO    ][24110] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-19 06:22:23,935 [salt.utils.extmods][INFO    ][24110] Syncing output for environment 'base'
2017-09-19 06:22:23,935 [salt.utils.extmods][INFO    ][24110] Loading cache from salt://_output, for base)
2017-09-19 06:22:23,936 [salt.fileclient  ][INFO    ][24110] Caching directory '_output/' for environment 'base'
2017-09-19 06:22:23,966 [salt.utils.extmods][INFO    ][24110] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-19 06:22:23,969 [salt.utils.extmods][INFO    ][24110] Syncing utils for environment 'base'
2017-09-19 06:22:23,969 [salt.utils.extmods][INFO    ][24110] Loading cache from salt://_utils, for base)
2017-09-19 06:22:23,969 [salt.fileclient  ][INFO    ][24110] Caching directory '_utils/' for environment 'base'
2017-09-19 06:22:24,005 [salt.utils.extmods][INFO    ][24110] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-19 06:22:24,007 [salt.utils.extmods][INFO    ][24110] Syncing log_handlers for environment 'base'
2017-09-19 06:22:24,007 [salt.utils.extmods][INFO    ][24110] Loading cache from salt://_log_handlers, for base)
2017-09-19 06:22:24,007 [salt.fileclient  ][INFO    ][24110] Caching directory '_log_handlers/' for environment 'base'
2017-09-19 06:22:24,059 [salt.utils.extmods][INFO    ][24110] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-19 06:22:24,061 [salt.utils.extmods][INFO    ][24110] Syncing proxy for environment 'base'
2017-09-19 06:22:24,062 [salt.utils.extmods][INFO    ][24110] Loading cache from salt://_proxy, for base)
2017-09-19 06:22:24,062 [salt.fileclient  ][INFO    ][24110] Caching directory '_proxy/' for environment 'base'
2017-09-19 06:22:24,095 [salt.utils.extmods][INFO    ][24110] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-19 06:22:24,098 [salt.utils.extmods][INFO    ][24110] Syncing engines for environment 'base'
2017-09-19 06:22:24,098 [salt.utils.extmods][INFO    ][24110] Loading cache from salt://_engines, for base)
2017-09-19 06:22:24,098 [salt.fileclient  ][INFO    ][24110] Caching directory '_engines/' for environment 'base'
2017-09-19 06:22:24,136 [salt.minion      ][INFO    ][24110] Returning information for job: 20170919062220775748
2017-09-19 06:22:30,690 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command state.sls with jid 20170919062230701851
2017-09-19 06:22:30,704 [salt.minion      ][INFO    ][24211] Starting a new job with PID 24211
2017-09-19 06:22:31,040 [salt.state       ][INFO    ][24211] Loading fresh modules for state activity
2017-09-19 06:22:31,065 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-19 06:22:31,083 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-19 06:22:31,243 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-19 06:22:31,313 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-19 06:22:31,327 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-19 06:22:31,424 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-19 06:22:31,476 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-19 06:22:31,492 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-19 06:22:31,531 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-19 06:22:31,548 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-19 06:22:31,559 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-19 06:22:31,646 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-19 06:22:31,653 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-19 06:22:31,676 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-19 06:22:31,691 [py.warnings      ][WARNING ][24211] /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-09-19 06:22:31,691 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'salt-minion --version' in directory '/root'
2017-09-19 06:22:31,930 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-19 06:22:31,955 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-19 06:22:31,967 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-19 06:22:31,978 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-19 06:22:32,075 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-19 06:22:32,110 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-19 06:22:32,249 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-19 06:22:32,270 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-19 06:22:32,322 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-19 06:22:32,342 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-19 06:22:32,381 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-19 06:22:32,398 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-19 06:22:32,411 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-19 06:22:32,425 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-19 06:22:32,432 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-19 06:22:32,560 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-19 06:22:32,574 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'salt-minion --version' in directory '/root'
2017-09-19 06:22:32,821 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-19 06:22:32,840 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-19 06:22:32,850 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-19 06:22:32,861 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-19 06:22:32,963 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-19 06:22:32,998 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-19 06:22:33,063 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-19 06:22:33,184 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-19 06:22:33,708 [salt.state       ][INFO    ][24211] Running state [salt-minion] at time 06:22:33.708177
2017-09-19 06:22:33,709 [salt.state       ][INFO    ][24211] Executing state pkg.installed for salt-minion
2017-09-19 06:22:33,709 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 06:22:33,986 [salt.state       ][INFO    ][24211] Package salt-minion is already installed
2017-09-19 06:22:34,050 [salt.state       ][INFO    ][24211] Completed state [salt-minion] at time 06:22:34.049718 duration_in_ms=341.54
2017-09-19 06:22:34,050 [salt.state       ][INFO    ][24211] Running state [python-yaml] at time 06:22:34.050258
2017-09-19 06:22:34,050 [salt.state       ][INFO    ][24211] Executing state pkg.installed for python-yaml
2017-09-19 06:22:34,053 [salt.state       ][INFO    ][24211] Package python-yaml is already installed
2017-09-19 06:22:34,053 [salt.state       ][INFO    ][24211] Completed state [python-yaml] at time 06:22:34.053250 duration_in_ms=2.991
2017-09-19 06:22:34,053 [salt.state       ][INFO    ][24211] Running state [python-psutil] at time 06:22:34.053407
2017-09-19 06:22:34,054 [salt.state       ][INFO    ][24211] Executing state pkg.installed for python-psutil
2017-09-19 06:22:34,056 [salt.state       ][INFO    ][24211] Package python-psutil is already installed
2017-09-19 06:22:34,056 [salt.state       ][INFO    ][24211] Completed state [python-psutil] at time 06:22:34.056264 duration_in_ms=2.856
2017-09-19 06:22:34,056 [salt.state       ][INFO    ][24211] Running state [python-m2crypto] at time 06:22:34.056416
2017-09-19 06:22:34,057 [salt.state       ][INFO    ][24211] Executing state pkg.installed for python-m2crypto
2017-09-19 06:22:34,059 [salt.state       ][INFO    ][24211] Package python-m2crypto is already installed
2017-09-19 06:22:34,059 [salt.state       ][INFO    ][24211] Completed state [python-m2crypto] at time 06:22:34.059208 duration_in_ms=2.791
2017-09-19 06:22:34,061 [salt.state       ][INFO    ][24211] Running state [/etc/salt/minion.d/minion.conf] at time 06:22:34.060826
2017-09-19 06:22:34,061 [salt.state       ][INFO    ][24211] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-19 06:22:34,196 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-19 06:22:34,243 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-19 06:22:34,285 [salt.fileclient  ][INFO    ][24211] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-19 06:22:34,314 [salt.state       ][INFO    ][24211] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-19 06:22:34,314 [salt.state       ][INFO    ][24211] Completed state [/etc/salt/minion.d/minion.conf] at time 06:22:34.314181 duration_in_ms=253.355
2017-09-19 06:22:34,315 [salt.state       ][INFO    ][24211] Running state [/etc/salt/minion.d/_virt.conf] at time 06:22:34.314497
2017-09-19 06:22:34,315 [salt.state       ][INFO    ][24211] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-19 06:22:34,440 [salt.state       ][INFO    ][24211] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-19 06:22:34,440 [salt.state       ][INFO    ][24211] Completed state [/etc/salt/minion.d/_virt.conf] at time 06:22:34.439752 duration_in_ms=125.254
2017-09-19 06:22:34,441 [salt.state       ][INFO    ][24211] Running state [salt-minion] at time 06:22:34.441075
2017-09-19 06:22:34,441 [salt.state       ][INFO    ][24211] Executing state service.running for salt-minion
2017-09-19 06:22:34,442 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-19 06:22:34,454 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-19 06:22:34,460 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-19 06:22:34,466 [salt.state       ][INFO    ][24211] The service salt-minion is already running
2017-09-19 06:22:34,466 [salt.state       ][INFO    ][24211] Completed state [salt-minion] at time 06:22:34.465987 duration_in_ms=24.911
2017-09-19 06:22:34,467 [salt.state       ][INFO    ][24211] Running state [/etc/salt/grains.d] at time 06:22:34.467083
2017-09-19 06:22:34,467 [salt.state       ][INFO    ][24211] Executing state file.directory for /etc/salt/grains.d
2017-09-19 06:22:34,468 [salt.state       ][INFO    ][24211] Directory /etc/salt/grains.d is in the correct state
2017-09-19 06:22:34,468 [salt.state       ][INFO    ][24211] Completed state [/etc/salt/grains.d] at time 06:22:34.468021 duration_in_ms=0.938
2017-09-19 06:22:34,469 [salt.state       ][INFO    ][24211] Running state [/etc/salt/grains] at time 06:22:34.468505
2017-09-19 06:22:34,469 [salt.state       ][INFO    ][24211] Executing state file.managed for /etc/salt/grains
2017-09-19 06:22:34,469 [salt.state       ][INFO    ][24211] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-19 06:22:34,469 [salt.state       ][INFO    ][24211] Completed state [/etc/salt/grains] at time 06:22:34.469230 duration_in_ms=0.724
2017-09-19 06:22:34,470 [salt.state       ][INFO    ][24211] Running state [/etc/salt/grains.d/placeholder] at time 06:22:34.469564
2017-09-19 06:22:34,470 [salt.state       ][INFO    ][24211] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-19 06:22:34,470 [salt.state       ][INFO    ][24211] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-19 06:22:34,470 [salt.state       ][INFO    ][24211] Completed state [/etc/salt/grains.d/placeholder] at time 06:22:34.470259 duration_in_ms=0.695
2017-09-19 06:22:34,471 [salt.state       ][INFO    ][24211] Running state [/etc/salt/grains.d/sphinx] at time 06:22:34.470587
2017-09-19 06:22:34,471 [salt.state       ][INFO    ][24211] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-19 06:22:34,517 [salt.state       ][INFO    ][24211] File /etc/salt/grains.d/sphinx is in the correct state
2017-09-19 06:22:34,517 [salt.state       ][INFO    ][24211] Completed state [/etc/salt/grains.d/sphinx] at time 06:22:34.517374 duration_in_ms=46.786
2017-09-19 06:22:34,518 [salt.state       ][INFO    ][24211] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:22:34.517884
2017-09-19 06:22:34,518 [salt.state       ][INFO    ][24211] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-19 06:22:34,518 [salt.state       ][INFO    ][24211] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-19 06:22:34,519 [salt.state       ][INFO    ][24211] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 06:22:34.518490 duration_in_ms=0.606
2017-09-19 06:22:34,519 [salt.state       ][INFO    ][24211] Running state [/etc/salt/grains.d/dns_records] at time 06:22:34.518841
2017-09-19 06:22:34,519 [salt.state       ][INFO    ][24211] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-19 06:22:34,589 [salt.state       ][INFO    ][24211] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-19 06:22:34,589 [salt.state       ][INFO    ][24211] Completed state [/etc/salt/grains.d/dns_records] at time 06:22:34.589365 duration_in_ms=70.523
2017-09-19 06:22:34,590 [salt.state       ][INFO    ][24211] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 06:22:34.589904
2017-09-19 06:22:34,590 [salt.state       ][INFO    ][24211] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-19 06:22:34,590 [salt.state       ][INFO    ][24211] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-19 06:22:34,591 [salt.state       ][INFO    ][24211] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 06:22:34.590561 duration_in_ms=0.657
2017-09-19 06:22:34,591 [salt.state       ][INFO    ][24211] Running state [/etc/salt/grains.d/salt] at time 06:22:34.590923
2017-09-19 06:22:34,591 [salt.state       ][INFO    ][24211] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-19 06:22:34,719 [salt.state       ][INFO    ][24211] File /etc/salt/grains.d/salt is in the correct state
2017-09-19 06:22:34,719 [salt.state       ][INFO    ][24211] Completed state [/etc/salt/grains.d/salt] at time 06:22:34.718774 duration_in_ms=127.85
2017-09-19 06:22:34,719 [salt.state       ][INFO    ][24211] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 06:22:34.719336
2017-09-19 06:22:34,720 [salt.state       ][INFO    ][24211] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-19 06:22:34,720 [salt.state       ][INFO    ][24211] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-19 06:22:34,720 [salt.state       ][INFO    ][24211] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 06:22:34.719909 duration_in_ms=0.573
2017-09-19 06:22:34,721 [salt.state       ][INFO    ][24211] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:22:34.721117
2017-09-19 06:22:34,721 [salt.state       ][INFO    ][24211] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-19 06:22:34,722 [salt.state       ][INFO    ][24211] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-19 06:22:34,722 [salt.state       ][INFO    ][24211] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 06:22:34.721654 duration_in_ms=0.537
2017-09-19 06:22:34,722 [salt.state       ][INFO    ][24211] Running state [mine.update] at time 06:22:34.722104
2017-09-19 06:22:34,722 [salt.state       ][INFO    ][24211] Executing state module.wait for mine.update
2017-09-19 06:22:34,723 [salt.state       ][INFO    ][24211] No changes made for mine.update
2017-09-19 06:22:34,723 [salt.state       ][INFO    ][24211] Completed state [mine.update] at time 06:22:34.722624 duration_in_ms=0.519
2017-09-19 06:22:34,723 [salt.state       ][INFO    ][24211] Running state [ca-certificates] at time 06:22:34.722791
2017-09-19 06:22:34,723 [salt.state       ][INFO    ][24211] Executing state pkg.installed for ca-certificates
2017-09-19 06:22:34,726 [salt.state       ][INFO    ][24211] Package ca-certificates is already installed
2017-09-19 06:22:34,726 [salt.state       ][INFO    ][24211] Completed state [ca-certificates] at time 06:22:34.726120 duration_in_ms=3.329
2017-09-19 06:22:34,727 [salt.state       ][INFO    ][24211] Running state [update-ca-certificates] at time 06:22:34.726549
2017-09-19 06:22:34,727 [salt.state       ][INFO    ][24211] Executing state cmd.wait for update-ca-certificates
2017-09-19 06:22:34,727 [salt.state       ][INFO    ][24211] No changes made for update-ca-certificates
2017-09-19 06:22:34,727 [salt.state       ][INFO    ][24211] Completed state [update-ca-certificates] at time 06:22:34.727099 duration_in_ms=0.551
2017-09-19 06:22:34,727 [salt.state       ][INFO    ][24211] Running state [libvirt-dev] at time 06:22:34.727274
2017-09-19 06:22:34,727 [salt.state       ][INFO    ][24211] Executing state pkg.installed for libvirt-dev
2017-09-19 06:22:34,730 [salt.state       ][INFO    ][24211] Package libvirt-dev is already installed
2017-09-19 06:22:34,730 [salt.state       ][INFO    ][24211] Completed state [libvirt-dev] at time 06:22:34.730184 duration_in_ms=2.909
2017-09-19 06:22:34,730 [salt.state       ][INFO    ][24211] Running state [pkg-config] at time 06:22:34.730340
2017-09-19 06:22:34,731 [salt.state       ][INFO    ][24211] Executing state pkg.installed for pkg-config
2017-09-19 06:22:34,733 [salt.state       ][INFO    ][24211] Package pkg-config is already installed
2017-09-19 06:22:34,733 [salt.state       ][INFO    ][24211] Completed state [pkg-config] at time 06:22:34.733392 duration_in_ms=3.053
2017-09-19 06:22:34,734 [salt.state       ][INFO    ][24211] Running state [virtng.init] at time 06:22:34.733551
2017-09-19 06:22:34,734 [salt.state       ][INFO    ][24211] Executing state module.run for virtng.init
2017-09-19 06:22:34,793 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command ['git', '--version'] in directory '/root'
2017-09-19 06:22:34,879 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-19 06:22:34,896 [salt.state       ][INFO    ][24211] unless execution succeeded
2017-09-19 06:22:34,897 [salt.state       ][INFO    ][24211] Completed state [virtng.init] at time 06:22:34.896643 duration_in_ms=163.089
2017-09-19 06:22:34,897 [salt.state       ][INFO    ][24211] Running state [virt.set_autostart] at time 06:22:34.896859
2017-09-19 06:22:34,897 [salt.state       ][INFO    ][24211] Executing state module.run for virt.set_autostart
2017-09-19 06:22:34,899 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-19 06:22:34,913 [salt.state       ][INFO    ][24211] unless execution succeeded
2017-09-19 06:22:34,913 [salt.state       ][INFO    ][24211] Completed state [virt.set_autostart] at time 06:22:34.913170 duration_in_ms=16.311
2017-09-19 06:22:34,913 [salt.state       ][INFO    ][24211] Running state [virtng.init] at time 06:22:34.913359
2017-09-19 06:22:34,914 [salt.state       ][INFO    ][24211] Executing state module.run for virtng.init
2017-09-19 06:22:34,915 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-19 06:22:34,928 [salt.state       ][INFO    ][24211] unless execution succeeded
2017-09-19 06:22:34,928 [salt.state       ][INFO    ][24211] Completed state [virtng.init] at time 06:22:34.927998 duration_in_ms=14.64
2017-09-19 06:22:34,928 [salt.state       ][INFO    ][24211] Running state [virt.set_autostart] at time 06:22:34.928185
2017-09-19 06:22:34,928 [salt.state       ][INFO    ][24211] Executing state module.run for virt.set_autostart
2017-09-19 06:22:34,930 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-19 06:22:34,942 [salt.state       ][INFO    ][24211] unless execution succeeded
2017-09-19 06:22:34,942 [salt.state       ][INFO    ][24211] Completed state [virt.set_autostart] at time 06:22:34.942291 duration_in_ms=14.106
2017-09-19 06:22:34,942 [salt.state       ][INFO    ][24211] Running state [virtng.init] at time 06:22:34.942476
2017-09-19 06:22:34,943 [salt.state       ][INFO    ][24211] Executing state module.run for virtng.init
2017-09-19 06:22:34,944 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-19 06:22:34,959 [salt.state       ][INFO    ][24211] unless execution succeeded
2017-09-19 06:22:34,973 [salt.state       ][INFO    ][24211] Completed state [virtng.init] at time 06:22:34.973128 duration_in_ms=30.651
2017-09-19 06:22:34,973 [salt.state       ][INFO    ][24211] Running state [virt.set_autostart] at time 06:22:34.973349
2017-09-19 06:22:34,974 [salt.state       ][INFO    ][24211] Executing state module.run for virt.set_autostart
2017-09-19 06:22:34,975 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-19 06:22:34,991 [salt.state       ][INFO    ][24211] unless execution succeeded
2017-09-19 06:22:34,991 [salt.state       ][INFO    ][24211] Completed state [virt.set_autostart] at time 06:22:34.991261 duration_in_ms=17.91
2017-09-19 06:22:34,991 [salt.state       ][INFO    ][24211] Running state [virtng.init] at time 06:22:34.991459
2017-09-19 06:22:34,992 [salt.state       ][INFO    ][24211] Executing state module.run for virtng.init
2017-09-19 06:22:34,993 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-19 06:22:35,008 [salt.state       ][INFO    ][24211] unless execution succeeded
2017-09-19 06:22:35,008 [salt.state       ][INFO    ][24211] Completed state [virtng.init] at time 06:22:35.008397 duration_in_ms=16.937
2017-09-19 06:22:35,009 [salt.state       ][INFO    ][24211] Running state [virt.set_autostart] at time 06:22:35.008593
2017-09-19 06:22:35,009 [salt.state       ][INFO    ][24211] Executing state module.run for virt.set_autostart
2017-09-19 06:22:35,011 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-19 06:22:35,023 [salt.state       ][INFO    ][24211] unless execution succeeded
2017-09-19 06:22:35,024 [salt.state       ][INFO    ][24211] Completed state [virt.set_autostart] at time 06:22:35.023470 duration_in_ms=14.877
2017-09-19 06:22:35,024 [salt.state       ][INFO    ][24211] Running state [virtng.init] at time 06:22:35.023670
2017-09-19 06:22:35,024 [salt.state       ][INFO    ][24211] Executing state module.run for virtng.init
2017-09-19 06:22:35,026 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-19 06:22:35,039 [salt.state       ][INFO    ][24211] unless execution succeeded
2017-09-19 06:22:35,040 [salt.state       ][INFO    ][24211] Completed state [virtng.init] at time 06:22:35.039622 duration_in_ms=15.951
2017-09-19 06:22:35,040 [salt.state       ][INFO    ][24211] Running state [virt.set_autostart] at time 06:22:35.039825
2017-09-19 06:22:35,040 [salt.state       ][INFO    ][24211] Executing state module.run for virt.set_autostart
2017-09-19 06:22:35,042 [salt.loaded.int.module.cmdmod][INFO    ][24211] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-19 06:22:35,055 [salt.state       ][INFO    ][24211] unless execution succeeded
2017-09-19 06:22:35,056 [salt.state       ][INFO    ][24211] Completed state [virt.set_autostart] at time 06:22:35.055563 duration_in_ms=15.737
2017-09-19 06:22:35,058 [salt.minion      ][INFO    ][24211] Returning information for job: 20170919062230701851
2017-09-19 06:23:49,239 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170919062349239123
2017-09-19 06:23:49,257 [salt.minion      ][INFO    ][24312] Starting a new job with PID 24312
2017-09-19 06:23:53,176 [salt.state       ][INFO    ][24312] Loading fresh modules for state activity
2017-09-19 06:23:53,960 [salt.state       ][ERROR   ][24312] No contents found in top file
2017-09-19 06:23:53,961 [salt.utils.extmods][INFO    ][24312] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-19 06:23:53,964 [salt.utils.extmods][INFO    ][24312] Syncing beacons for environment 'base'
2017-09-19 06:23:53,964 [salt.utils.extmods][INFO    ][24312] Loading cache from salt://_beacons, for base)
2017-09-19 06:23:53,964 [salt.fileclient  ][INFO    ][24312] Caching directory '_beacons/' for environment 'base'
2017-09-19 06:23:54,028 [salt.utils.extmods][INFO    ][24312] Syncing modules for environment 'base'
2017-09-19 06:23:54,028 [salt.utils.extmods][INFO    ][24312] Loading cache from salt://_modules, for base)
2017-09-19 06:23:54,028 [salt.fileclient  ][INFO    ][24312] Caching directory '_modules/' for environment 'base'
2017-09-19 06:23:54,124 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-19 06:23:54,141 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-19 06:23:54,154 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-19 06:23:54,163 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-19 06:23:54,179 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-19 06:23:54,194 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-19 06:23:54,206 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-19 06:23:54,219 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-19 06:23:54,228 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-19 06:23:54,432 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-19 06:23:54,536 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-19 06:23:54,566 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-19 06:23:54,599 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-19 06:23:54,620 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-19 06:23:54,651 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-19 06:23:54,703 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-19 06:23:54,711 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-19 06:23:54,734 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-19 06:23:54,762 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-19 06:23:54,776 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-19 06:23:54,814 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-19 06:23:54,828 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-19 06:23:54,863 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-19 06:23:54,925 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-19 06:23:55,019 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-19 06:23:55,049 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-19 06:23:55,065 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-19 06:23:55,192 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-19 06:23:55,267 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-19 06:23:55,280 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-19 06:23:55,290 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-19 06:23:55,303 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-19 06:23:55,306 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-19 06:23:55,306 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-19 06:23:55,306 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-19 06:23:55,306 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-19 06:23:55,307 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-19 06:23:55,307 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-19 06:23:55,307 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-19 06:23:55,307 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-19 06:23:55,308 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-19 06:23:55,308 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-19 06:23:55,308 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-19 06:23:55,308 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-19 06:23:55,308 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-19 06:23:55,309 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-19 06:23:55,309 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-19 06:23:55,309 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-19 06:23:55,309 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-19 06:23:55,309 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-19 06:23:55,310 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-19 06:23:55,310 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-19 06:23:55,310 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-19 06:23:55,310 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-19 06:23:55,311 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-19 06:23:55,311 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-19 06:23:55,311 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-19 06:23:55,311 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-19 06:23:55,311 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-19 06:23:55,312 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-19 06:23:55,312 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-19 06:23:55,312 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-19 06:23:55,312 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-19 06:23:55,313 [salt.utils.extmods][INFO    ][24312] 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-09-19 06:23:55,313 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-19 06:23:55,313 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-19 06:23:55,317 [salt.utils.extmods][INFO    ][24312] Syncing states for environment 'base'
2017-09-19 06:23:55,317 [salt.utils.extmods][INFO    ][24312] Loading cache from salt://_states, for base)
2017-09-19 06:23:55,318 [salt.fileclient  ][INFO    ][24312] Caching directory '_states/' for environment 'base'
2017-09-19 06:23:55,364 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-19 06:23:55,382 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-19 06:23:55,401 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-19 06:23:55,412 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-19 06:23:55,453 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-19 06:23:55,475 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-19 06:23:55,531 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-19 06:23:55,588 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-19 06:23:55,599 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-19 06:23:55,662 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-19 06:23:55,697 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-19 06:23:55,719 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-19 06:23:55,746 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-19 06:23:55,780 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-19 06:23:55,810 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-19 06:23:55,823 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-19 06:23:55,909 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-19 06:23:55,929 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-19 06:23:55,946 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-19 06:23:55,965 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-19 06:23:55,977 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-19 06:23:56,019 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-19 06:23:56,028 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-19 06:23:56,055 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-19 06:23:56,079 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-19 06:23:56,095 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-19 06:23:56,116 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-19 06:23:56,123 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-19 06:23:56,131 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-19 06:23:56,133 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-19 06:23:56,134 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-19 06:23:56,134 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-19 06:23:56,134 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-19 06:23:56,134 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-19 06:23:56,134 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-19 06:23:56,135 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-19 06:23:56,135 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-19 06:23:56,135 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-19 06:23:56,135 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-19 06:23:56,135 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-19 06:23:56,136 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-19 06:23:56,136 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-19 06:23:56,136 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-19 06:23:56,136 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-19 06:23:56,136 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-19 06:23:56,137 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-19 06:23:56,137 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-19 06:23:56,137 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-19 06:23:56,137 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-19 06:23:56,137 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-19 06:23:56,137 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-19 06:23:56,138 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-19 06:23:56,138 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-19 06:23:56,138 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-19 06:23:56,138 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-19 06:23:56,138 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-19 06:23:56,139 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-19 06:23:56,139 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-19 06:23:56,139 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-19 06:23:56,141 [salt.utils.extmods][INFO    ][24312] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-19 06:23:56,143 [salt.utils.extmods][INFO    ][24312] Syncing sdb for environment 'base'
2017-09-19 06:23:56,144 [salt.utils.extmods][INFO    ][24312] Loading cache from salt://_sdb, for base)
2017-09-19 06:23:56,144 [salt.fileclient  ][INFO    ][24312] Caching directory '_sdb/' for environment 'base'
2017-09-19 06:23:56,224 [salt.utils.extmods][INFO    ][24312] Syncing grains for environment 'base'
2017-09-19 06:23:56,224 [salt.utils.extmods][INFO    ][24312] Loading cache from salt://_grains, for base)
2017-09-19 06:23:56,224 [salt.fileclient  ][INFO    ][24312] Caching directory '_grains/' for environment 'base'
2017-09-19 06:23:56,280 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-19 06:23:56,350 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-19 06:23:56,360 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-19 06:23:56,404 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-19 06:23:56,452 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-19 06:23:56,555 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-19 06:23:56,636 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-19 06:23:56,665 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-19 06:23:56,680 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-19 06:23:56,686 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-19 06:23:56,710 [salt.fileclient  ][INFO    ][24312] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-19 06:23:56,712 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-19 06:23:56,712 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-19 06:23:56,713 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-19 06:23:56,713 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-19 06:23:56,713 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-19 06:23:56,713 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-19 06:23:56,714 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-19 06:23:56,714 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-19 06:23:56,714 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-19 06:23:56,714 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-19 06:23:56,714 [salt.utils.extmods][INFO    ][24312] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-19 06:23:56,716 [salt.utils.extmods][INFO    ][24312] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-19 06:23:56,718 [salt.utils.extmods][INFO    ][24312] Syncing renderers for environment 'base'
2017-09-19 06:23:56,718 [salt.utils.extmods][INFO    ][24312] Loading cache from salt://_renderers, for base)
2017-09-19 06:23:56,718 [salt.fileclient  ][INFO    ][24312] Caching directory '_renderers/' for environment 'base'
2017-09-19 06:23:56,778 [salt.utils.extmods][INFO    ][24312] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-19 06:23:56,780 [salt.utils.extmods][INFO    ][24312] Syncing returners for environment 'base'
2017-09-19 06:23:56,780 [salt.utils.extmods][INFO    ][24312] Loading cache from salt://_returners, for base)
2017-09-19 06:23:56,780 [salt.fileclient  ][INFO    ][24312] Caching directory '_returners/' for environment 'base'
2017-09-19 06:23:56,910 [salt.utils.extmods][INFO    ][24312] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-19 06:23:56,912 [salt.utils.extmods][INFO    ][24312] Syncing output for environment 'base'
2017-09-19 06:23:56,912 [salt.utils.extmods][INFO    ][24312] Loading cache from salt://_output, for base)
2017-09-19 06:23:56,912 [salt.fileclient  ][INFO    ][24312] Caching directory '_output/' for environment 'base'
2017-09-19 06:23:56,957 [salt.utils.extmods][INFO    ][24312] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-19 06:23:56,959 [salt.utils.extmods][INFO    ][24312] Syncing utils for environment 'base'
2017-09-19 06:23:56,959 [salt.utils.extmods][INFO    ][24312] Loading cache from salt://_utils, for base)
2017-09-19 06:23:56,959 [salt.fileclient  ][INFO    ][24312] Caching directory '_utils/' for environment 'base'
2017-09-19 06:23:57,029 [salt.utils.extmods][INFO    ][24312] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-19 06:23:57,031 [salt.utils.extmods][INFO    ][24312] Syncing log_handlers for environment 'base'
2017-09-19 06:23:57,031 [salt.utils.extmods][INFO    ][24312] Loading cache from salt://_log_handlers, for base)
2017-09-19 06:23:57,031 [salt.fileclient  ][INFO    ][24312] Caching directory '_log_handlers/' for environment 'base'
2017-09-19 06:23:57,074 [salt.utils.extmods][INFO    ][24312] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-19 06:23:57,076 [salt.utils.extmods][INFO    ][24312] Syncing proxy for environment 'base'
2017-09-19 06:23:57,076 [salt.utils.extmods][INFO    ][24312] Loading cache from salt://_proxy, for base)
2017-09-19 06:23:57,076 [salt.fileclient  ][INFO    ][24312] Caching directory '_proxy/' for environment 'base'
2017-09-19 06:23:57,106 [salt.utils.extmods][INFO    ][24312] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-19 06:23:57,108 [salt.utils.extmods][INFO    ][24312] Syncing engines for environment 'base'
2017-09-19 06:23:57,108 [salt.utils.extmods][INFO    ][24312] Loading cache from salt://_engines, for base)
2017-09-19 06:23:57,109 [salt.fileclient  ][INFO    ][24312] Caching directory '_engines/' for environment 'base'
2017-09-19 06:23:57,153 [salt.minion      ][INFO    ][24312] Returning information for job: 20170919062349239123
2017-09-19 06:38:20,535 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command test.ping with jid 20170919063820520909
2017-09-19 06:38:20,555 [salt.minion      ][INFO    ][25087] Starting a new job with PID 25087
2017-09-19 06:38:20,580 [salt.minion      ][INFO    ][25087] Returning information for job: 20170919063820520909
2017-09-19 06:40:35,231 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command state.sls with jid 20170919064035216505
2017-09-19 06:40:35,243 [salt.minion      ][INFO    ][25138] Starting a new job with PID 25138
2017-09-19 06:40:35,661 [salt.state       ][INFO    ][25138] Loading fresh modules for state activity
2017-09-19 06:40:35,684 [salt.fileclient  ][INFO    ][25138] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-19 06:40:35,700 [salt.fileclient  ][INFO    ][25138] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-19 06:40:35,723 [salt.fileclient  ][INFO    ][25138] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-19 06:40:36,009 [salt.state       ][INFO    ][25138] Running state [lsof] at time 06:40:36.009345
2017-09-19 06:40:36,010 [salt.state       ][INFO    ][25138] Executing state pkg.installed for lsof
2017-09-19 06:40:36,010 [salt.loaded.int.module.cmdmod][INFO    ][25138] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 06:40:36,286 [salt.state       ][INFO    ][25138] Package lsof is already installed
2017-09-19 06:40:36,286 [salt.state       ][INFO    ][25138] Completed state [lsof] at time 06:40:36.285944 duration_in_ms=276.598
2017-09-19 06:40:36,286 [salt.state       ][INFO    ][25138] Running state [keepalived] at time 06:40:36.286162
2017-09-19 06:40:36,286 [salt.state       ][INFO    ][25138] Executing state pkg.installed for keepalived
2017-09-19 06:40:36,301 [salt.loaded.int.module.cmdmod][INFO    ][25138] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-19 06:40:38,333 [salt.loaded.int.module.cmdmod][INFO    ][25138] 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-09-19 06:40:45,278 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919064045261201
2017-09-19 06:40:45,293 [salt.minion      ][INFO    ][26400] Starting a new job with PID 26400
2017-09-19 06:40:45,303 [salt.minion      ][INFO    ][26400] Returning information for job: 20170919064045261201
2017-09-19 06:40:47,082 [salt.loaded.int.module.cmdmod][INFO    ][25138] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 06:40:47,105 [salt.state       ][INFO    ][25138] 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-09-19 06:40:47,113 [salt.state       ][INFO    ][25138] Loading fresh modules for state activity
2017-09-19 06:40:47,125 [salt.state       ][INFO    ][25138] Completed state [keepalived] at time 06:40:47.124963 duration_in_ms=10838.801
2017-09-19 06:40:47,127 [salt.state       ][INFO    ][25138] Running state [/etc/keepalived/keepalived.conf] at time 06:40:47.127111
2017-09-19 06:40:47,127 [salt.state       ][INFO    ][25138] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-19 06:40:47,154 [salt.fileclient  ][INFO    ][25138] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-19 06:40:47,185 [salt.fileclient  ][INFO    ][25138] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-19 06:40:47,191 [salt.state       ][INFO    ][25138] File changed:
New file
2017-09-19 06:40:47,191 [salt.state       ][INFO    ][25138] Completed state [/etc/keepalived/keepalived.conf] at time 06:40:47.191219 duration_in_ms=64.107
2017-09-19 06:40:47,248 [salt.state       ][INFO    ][25138] Running state [keepalived] at time 06:40:47.247616
2017-09-19 06:40:47,248 [salt.state       ][INFO    ][25138] Executing state service.running for keepalived
2017-09-19 06:40:47,249 [salt.loaded.int.module.cmdmod][INFO    ][25138] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-19 06:40:47,258 [salt.loaded.int.module.cmdmod][INFO    ][25138] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-19 06:40:47,265 [salt.loaded.int.module.cmdmod][INFO    ][25138] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-19 06:40:47,272 [salt.loaded.int.module.cmdmod][INFO    ][25138] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-19 06:40:47,279 [salt.loaded.int.module.cmdmod][INFO    ][25138] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-19 06:40:47,344 [salt.loaded.int.module.cmdmod][INFO    ][25138] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-19 06:40:47,351 [salt.loaded.int.module.cmdmod][INFO    ][25138] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-19 06:40:47,359 [salt.loaded.int.module.cmdmod][INFO    ][25138] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-19 06:40:47,365 [salt.state       ][INFO    ][25138] {'keepalived': True}
2017-09-19 06:40:47,365 [salt.state       ][INFO    ][25138] Completed state [keepalived] at time 06:40:47.365271 duration_in_ms=117.654
2017-09-19 06:40:47,366 [salt.minion      ][INFO    ][25138] Returning information for job: 20170919064035216505
2017-09-19 06:44:42,643 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command pillar.get with jid 20170919064442634068
2017-09-19 06:44:42,682 [salt.minion      ][INFO    ][26737] Starting a new job with PID 26737
2017-09-19 06:44:42,687 [salt.minion      ][INFO    ][26737] Returning information for job: 20170919064442634068
2017-09-19 06:50:10,614 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command state.sls with jid 20170919065010599176
2017-09-19 06:50:10,628 [salt.minion      ][INFO    ][26839] Starting a new job with PID 26839
2017-09-19 06:50:13,022 [salt.state       ][INFO    ][26839] Loading fresh modules for state activity
2017-09-19 06:50:13,044 [salt.fileclient  ][INFO    ][26839] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-19 06:50:13,062 [salt.fileclient  ][INFO    ][26839] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-19 06:50:13,342 [salt.state       ][INFO    ][26839] Running state [attr] at time 06:50:13.342120
2017-09-19 06:50:13,342 [salt.state       ][INFO    ][26839] Executing state pkg.installed for attr
2017-09-19 06:50:13,343 [salt.loaded.int.module.cmdmod][INFO    ][26839] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 06:50:13,650 [salt.loaded.int.module.cmdmod][INFO    ][26839] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-19 06:50:20,706 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919065020694831
2017-09-19 06:50:20,718 [salt.minion      ][INFO    ][27412] Starting a new job with PID 27412
2017-09-19 06:50:20,728 [salt.minion      ][INFO    ][27412] Returning information for job: 20170919065020694831
2017-09-19 06:50:20,735 [salt.loaded.int.module.cmdmod][INFO    ][26839] 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-09-19 06:50:23,134 [salt.loaded.int.module.cmdmod][INFO    ][26839] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 06:50:23,159 [salt.state       ][INFO    ][26839] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-19 06:50:23,167 [salt.state       ][INFO    ][26839] Loading fresh modules for state activity
2017-09-19 06:50:23,179 [salt.state       ][INFO    ][26839] Completed state [attr] at time 06:50:23.179045 duration_in_ms=9836.924
2017-09-19 06:50:23,184 [salt.state       ][INFO    ][26839] Running state [glusterfs-server] at time 06:50:23.183913
2017-09-19 06:50:23,184 [salt.state       ][INFO    ][26839] Executing state pkg.installed for glusterfs-server
2017-09-19 06:50:23,372 [salt.loaded.int.module.cmdmod][INFO    ][26839] 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-09-19 06:50:30,923 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919065030912772
2017-09-19 06:50:30,938 [salt.minion      ][INFO    ][27850] Starting a new job with PID 27850
2017-09-19 06:50:30,951 [salt.minion      ][INFO    ][27850] Returning information for job: 20170919065030912772
2017-09-19 06:50:41,116 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919065041104846
2017-09-19 06:50:41,131 [salt.minion      ][INFO    ][27858] Starting a new job with PID 27858
2017-09-19 06:50:41,142 [salt.minion      ][INFO    ][27858] Returning information for job: 20170919065041104846
2017-09-19 06:50:51,339 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919065051328847
2017-09-19 06:50:51,354 [salt.minion      ][INFO    ][27866] Starting a new job with PID 27866
2017-09-19 06:50:51,365 [salt.minion      ][INFO    ][27866] Returning information for job: 20170919065051328847
2017-09-19 06:51:01,535 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919065101525447
2017-09-19 06:51:01,550 [salt.minion      ][INFO    ][27872] Starting a new job with PID 27872
2017-09-19 06:51:01,562 [salt.minion      ][INFO    ][27872] Returning information for job: 20170919065101525447
2017-09-19 06:51:11,732 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919065111727818
2017-09-19 06:51:11,747 [salt.minion      ][INFO    ][27881] Starting a new job with PID 27881
2017-09-19 06:51:11,759 [salt.minion      ][INFO    ][27881] Returning information for job: 20170919065111727818
2017-09-19 06:51:21,972 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919065121962560
2017-09-19 06:51:21,986 [salt.minion      ][INFO    ][27891] Starting a new job with PID 27891
2017-09-19 06:51:21,998 [salt.minion      ][INFO    ][27891] Returning information for job: 20170919065121962560
2017-09-19 06:51:32,165 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919065132156093
2017-09-19 06:51:32,179 [salt.minion      ][INFO    ][27898] Starting a new job with PID 27898
2017-09-19 06:51:32,191 [salt.minion      ][INFO    ][27898] Returning information for job: 20170919065132156093
2017-09-19 06:51:42,382 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919065142364493
2017-09-19 06:51:42,396 [salt.minion      ][INFO    ][30637] Starting a new job with PID 30637
2017-09-19 06:51:42,408 [salt.minion      ][INFO    ][30637] Returning information for job: 20170919065142364493
2017-09-19 06:51:47,733 [salt.loaded.int.module.cmdmod][INFO    ][26839] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 06:51:47,758 [salt.state       ][INFO    ][26839] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-09-19 06:51:47,765 [salt.state       ][INFO    ][26839] Loading fresh modules for state activity
2017-09-19 06:51:47,777 [salt.state       ][INFO    ][26839] Completed state [glusterfs-server] at time 06:51:47.776637 duration_in_ms=84592.724
2017-09-19 06:51:47,781 [salt.state       ][INFO    ][26839] Running state [bc] at time 06:51:47.781162
2017-09-19 06:51:47,781 [salt.state       ][INFO    ][26839] Executing state pkg.installed for bc
2017-09-19 06:51:48,025 [salt.loaded.int.module.cmdmod][INFO    ][26839] 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-09-19 06:51:51,140 [salt.loaded.int.module.cmdmod][INFO    ][26839] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 06:51:51,169 [salt.state       ][INFO    ][26839] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-19 06:51:51,179 [salt.state       ][INFO    ][26839] Loading fresh modules for state activity
2017-09-19 06:51:51,193 [salt.state       ][INFO    ][26839] Completed state [bc] at time 06:51:51.193151 duration_in_ms=3411.989
2017-09-19 06:51:51,255 [salt.state       ][INFO    ][26839] Running state [glusterfs-server] at time 06:51:51.254467
2017-09-19 06:51:51,255 [salt.state       ][INFO    ][26839] Executing state service.running for glusterfs-server
2017-09-19 06:51:51,257 [salt.loaded.int.module.cmdmod][INFO    ][26839] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-19 06:51:51,265 [salt.loaded.int.module.cmdmod][INFO    ][26839] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-19 06:51:51,272 [salt.loaded.int.module.cmdmod][INFO    ][26839] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-19 06:51:51,279 [salt.state       ][INFO    ][26839] The service glusterfs-server is already running
2017-09-19 06:51:51,279 [salt.state       ][INFO    ][26839] Completed state [glusterfs-server] at time 06:51:51.278999 duration_in_ms=24.532
2017-09-19 06:51:51,280 [salt.state       ][INFO    ][26839] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:51:51.280313
2017-09-19 06:51:51,281 [salt.state       ][INFO    ][26839] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-19 06:51:51,295 [salt.state       ][INFO    ][26839] File changed:
New file
2017-09-19 06:51:51,295 [salt.state       ][INFO    ][26839] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:51:51.295336 duration_in_ms=15.021
2017-09-19 06:51:51,296 [salt.state       ][INFO    ][26839] Running state [/srv/glusterfs/glance] at time 06:51:51.295599
2017-09-19 06:51:51,296 [salt.state       ][INFO    ][26839] Executing state file.directory for /srv/glusterfs/glance
2017-09-19 06:51:51,297 [salt.state       ][INFO    ][26839] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-19 06:51:51,297 [salt.state       ][INFO    ][26839] Completed state [/srv/glusterfs/glance] at time 06:51:51.296693 duration_in_ms=1.094
2017-09-19 06:51:51,297 [salt.state       ][INFO    ][26839] Running state [/srv/glusterfs/keystone-keys] at time 06:51:51.296831
2017-09-19 06:51:51,297 [salt.state       ][INFO    ][26839] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-19 06:51:51,297 [salt.state       ][INFO    ][26839] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-19 06:51:51,297 [salt.state       ][INFO    ][26839] Completed state [/srv/glusterfs/keystone-keys] at time 06:51:51.297464 duration_in_ms=0.632
2017-09-19 06:51:51,298 [salt.state       ][INFO    ][26839] Running state [/srv/glusterfs/nova_instances] at time 06:51:51.297606
2017-09-19 06:51:51,298 [salt.state       ][INFO    ][26839] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-19 06:51:51,298 [salt.state       ][INFO    ][26839] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-19 06:51:51,298 [salt.state       ][INFO    ][26839] Completed state [/srv/glusterfs/nova_instances] at time 06:51:51.298257 duration_in_ms=0.652
2017-09-19 06:51:51,298 [salt.state       ][INFO    ][26839] Running state [/srv/glusterfs/keystone-credential-keys] at time 06:51:51.298452
2017-09-19 06:51:51,299 [salt.state       ][INFO    ][26839] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-19 06:51:51,299 [salt.state       ][INFO    ][26839] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-19 06:51:51,299 [salt.state       ][INFO    ][26839] Completed state [/srv/glusterfs/keystone-credential-keys] at time 06:51:51.299401 duration_in_ms=0.949
2017-09-19 06:51:51,300 [salt.minion      ][INFO    ][26839] Returning information for job: 20170919065010599176
2017-09-19 06:52:06,802 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command test.ping with jid 20170919065206796607
2017-09-19 06:52:06,817 [salt.minion      ][INFO    ][31638] Starting a new job with PID 31638
2017-09-19 06:52:06,843 [salt.minion      ][INFO    ][31638] Returning information for job: 20170919065206796607
2017-09-19 06:52:47,583 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command state.sls with jid 20170919065247575266
2017-09-19 06:52:47,597 [salt.minion      ][INFO    ][31856] Starting a new job with PID 31856
2017-09-19 06:52:48,957 [salt.state       ][INFO    ][31856] Loading fresh modules for state activity
2017-09-19 06:52:48,979 [salt.fileclient  ][INFO    ][31856] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-19 06:52:49,009 [salt.fileclient  ][INFO    ][31856] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-19 06:52:49,073 [salt.fileclient  ][INFO    ][31856] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-19 06:52:49,092 [salt.fileclient  ][INFO    ][31856] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-19 06:52:49,376 [salt.state       ][INFO    ][31856] Running state [attr] at time 06:52:49.376007
2017-09-19 06:52:49,376 [salt.state       ][INFO    ][31856] Executing state pkg.installed for attr
2017-09-19 06:52:49,377 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 06:52:49,657 [salt.state       ][INFO    ][31856] Package attr is already installed
2017-09-19 06:52:49,657 [salt.state       ][INFO    ][31856] Completed state [attr] at time 06:52:49.657441 duration_in_ms=281.434
2017-09-19 06:52:49,658 [salt.state       ][INFO    ][31856] Running state [glusterfs-server] at time 06:52:49.657638
2017-09-19 06:52:49,658 [salt.state       ][INFO    ][31856] Executing state pkg.installed for glusterfs-server
2017-09-19 06:52:49,660 [salt.state       ][INFO    ][31856] Package glusterfs-server is already installed
2017-09-19 06:52:49,661 [salt.state       ][INFO    ][31856] Completed state [glusterfs-server] at time 06:52:49.660608 duration_in_ms=2.97
2017-09-19 06:52:49,661 [salt.state       ][INFO    ][31856] Running state [bc] at time 06:52:49.660746
2017-09-19 06:52:49,661 [salt.state       ][INFO    ][31856] Executing state pkg.installed for bc
2017-09-19 06:52:49,663 [salt.state       ][INFO    ][31856] Package bc is already installed
2017-09-19 06:52:49,664 [salt.state       ][INFO    ][31856] Completed state [bc] at time 06:52:49.663565 duration_in_ms=2.82
2017-09-19 06:52:49,664 [salt.state       ][INFO    ][31856] Running state [glusterfs-server] at time 06:52:49.664348
2017-09-19 06:52:49,665 [salt.state       ][INFO    ][31856] Executing state service.running for glusterfs-server
2017-09-19 06:52:49,665 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-19 06:52:49,674 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-19 06:52:49,719 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-19 06:52:49,732 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-19 06:52:49,739 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-19 06:52:49,746 [salt.state       ][INFO    ][31856] The service glusterfs-server is already running
2017-09-19 06:52:49,747 [salt.state       ][INFO    ][31856] Completed state [glusterfs-server] at time 06:52:49.746595 duration_in_ms=82.246
2017-09-19 06:52:49,748 [salt.state       ][INFO    ][31856] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:52:49.747952
2017-09-19 06:52:49,748 [salt.state       ][INFO    ][31856] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-19 06:52:49,756 [salt.state       ][INFO    ][31856] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-19 06:52:49,757 [salt.state       ][INFO    ][31856] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 06:52:49.756474 duration_in_ms=8.521
2017-09-19 06:52:49,757 [salt.state       ][INFO    ][31856] Running state [/srv/glusterfs/glance] at time 06:52:49.756643
2017-09-19 06:52:49,757 [salt.state       ][INFO    ][31856] Executing state file.directory for /srv/glusterfs/glance
2017-09-19 06:52:49,757 [salt.state       ][INFO    ][31856] Directory /srv/glusterfs/glance is in the correct state
2017-09-19 06:52:49,757 [salt.state       ][INFO    ][31856] Completed state [/srv/glusterfs/glance] at time 06:52:49.757272 duration_in_ms=0.629
2017-09-19 06:52:49,757 [salt.state       ][INFO    ][31856] Running state [/srv/glusterfs/keystone-keys] at time 06:52:49.757411
2017-09-19 06:52:49,758 [salt.state       ][INFO    ][31856] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-19 06:52:49,758 [salt.state       ][INFO    ][31856] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-19 06:52:49,758 [salt.state       ][INFO    ][31856] Completed state [/srv/glusterfs/keystone-keys] at time 06:52:49.757978 duration_in_ms=0.566
2017-09-19 06:52:49,758 [salt.state       ][INFO    ][31856] Running state [/srv/glusterfs/nova_instances] at time 06:52:49.758117
2017-09-19 06:52:49,758 [salt.state       ][INFO    ][31856] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-19 06:52:49,759 [salt.state       ][INFO    ][31856] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-19 06:52:49,759 [salt.state       ][INFO    ][31856] Completed state [/srv/glusterfs/nova_instances] at time 06:52:49.758718 duration_in_ms=0.602
2017-09-19 06:52:49,759 [salt.state       ][INFO    ][31856] Running state [/srv/glusterfs/keystone-credential-keys] at time 06:52:49.758856
2017-09-19 06:52:49,759 [salt.state       ][INFO    ][31856] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-19 06:52:49,759 [salt.state       ][INFO    ][31856] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-19 06:52:49,759 [salt.state       ][INFO    ][31856] Completed state [/srv/glusterfs/keystone-credential-keys] at time 06:52:49.759428 duration_in_ms=0.572
2017-09-19 06:52:49,815 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command ['git', '--version'] in directory '/root'
2017-09-19 06:52:49,892 [salt.state       ][INFO    ][31856] Running state [sleep 5] at time 06:52:49.892046
2017-09-19 06:52:49,892 [salt.state       ][INFO    ][31856] Executing state cmd.wait for sleep 5
2017-09-19 06:52:49,892 [salt.state       ][INFO    ][31856] No changes made for sleep 5
2017-09-19 06:52:49,893 [salt.state       ][INFO    ][31856] Completed state [sleep 5] at time 06:52:49.892594 duration_in_ms=0.548
2017-09-19 06:52:49,893 [salt.state       ][INFO    ][31856] Running state [10.167.4.141] at time 06:52:49.892971
2017-09-19 06:52:49,893 [salt.state       ][INFO    ][31856] Executing state glusterfs.peered for 10.167.4.141
2017-09-19 06:52:49,893 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:49,903 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:49,950 [salt.state       ][INFO    ][31856] Host 10.167.4.141 already peered
2017-09-19 06:52:49,950 [salt.state       ][INFO    ][31856] Completed state [10.167.4.141] at time 06:52:49.950065 duration_in_ms=57.092
2017-09-19 06:52:49,952 [salt.state       ][INFO    ][31856] Running state [10.167.4.142] at time 06:52:49.952303
2017-09-19 06:52:49,953 [salt.state       ][INFO    ][31856] Executing state glusterfs.peered for 10.167.4.142
2017-09-19 06:52:49,953 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:49,962 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:50,015 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:50,023 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:50,075 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:50,084 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:50,135 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:50,143 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:50,190 [salt.state       ][INFO    ][31856] Peering with localhost is not needed
2017-09-19 06:52:50,191 [salt.state       ][INFO    ][31856] Completed state [10.167.4.142] at time 06:52:50.190475 duration_in_ms=238.172
2017-09-19 06:52:50,193 [salt.state       ][INFO    ][31856] Running state [10.167.4.143] at time 06:52:50.192774
2017-09-19 06:52:50,193 [salt.state       ][INFO    ][31856] Executing state glusterfs.peered for 10.167.4.143
2017-09-19 06:52:50,193 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:50,202 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:50,252 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:50,261 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:50,314 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:50,322 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:50,390 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:50,399 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:50,447 [salt.state       ][INFO    ][31856] {'new': {'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': ['10.167.4.143'], '10.167.4.141': []}, 'old': {'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': [], '10.167.4.141': []}}
2017-09-19 06:52:50,448 [salt.state       ][INFO    ][31856] Completed state [10.167.4.143] at time 06:52:50.447490 duration_in_ms=254.716
2017-09-19 06:52:50,448 [salt.state       ][INFO    ][31856] Running state [glance] at time 06:52:50.448314
2017-09-19 06:52:50,449 [salt.state       ][INFO    ][31856] Executing state glusterfs.created for glance
2017-09-19 06:52:50,449 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:50,456 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:50,504 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:50,511 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:50,563 [salt.state       ][INFO    ][31856] Volume glance already exists and is started.
2017-09-19 06:52:50,563 [salt.state       ][INFO    ][31856] Completed state [glance] at time 06:52:50.563121 duration_in_ms=114.806
2017-09-19 06:52:50,566 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 06:52:50.565709
2017-09-19 06:52:50,566 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-19 06:52:50,566 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-19 06:52:50,615 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:50,615 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 06:52:50.614999 duration_in_ms=49.289
2017-09-19 06:52:50,615 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 06:52:50.615420
2017-09-19 06:52:50,616 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-19 06:52:50,616 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-19 06:52:50,665 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:50,665 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 06:52:50.664844 duration_in_ms=49.423
2017-09-19 06:52:50,665 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 06:52:50.665306
2017-09-19 06:52:50,666 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-19 06:52:50,666 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-19 06:52:50,717 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:50,717 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 06:52:50.716947 duration_in_ms=51.641
2017-09-19 06:52:50,717 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 06:52:50.717422
2017-09-19 06:52:50,718 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-19 06:52:50,718 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-19 06:52:50,767 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:50,768 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 06:52:50.767683 duration_in_ms=50.26
2017-09-19 06:52:50,768 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 06:52:50.768131
2017-09-19 06:52:50,768 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-19 06:52:50,769 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-19 06:52:50,817 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:50,817 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 06:52:50.817361 duration_in_ms=49.23
2017-09-19 06:52:50,818 [salt.state       ][INFO    ][31856] Running state [glance] at time 06:52:50.818280
2017-09-19 06:52:50,819 [salt.state       ][INFO    ][31856] Executing state glusterfs.started for glance
2017-09-19 06:52:50,819 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:50,827 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:50,874 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:50,882 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:50,932 [salt.state       ][INFO    ][31856] Volume glance is already started
2017-09-19 06:52:50,933 [salt.state       ][INFO    ][31856] Completed state [glance] at time 06:52:50.932679 duration_in_ms=114.399
2017-09-19 06:52:50,934 [salt.state       ][INFO    ][31856] Running state [keystone-keys] at time 06:52:50.933495
2017-09-19 06:52:50,934 [salt.state       ][INFO    ][31856] Executing state glusterfs.created for keystone-keys
2017-09-19 06:52:50,934 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:50,942 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:50,989 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:50,996 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:51,048 [salt.state       ][INFO    ][31856] Volume keystone-keys already exists and is started.
2017-09-19 06:52:51,048 [salt.state       ][INFO    ][31856] Completed state [keystone-keys] at time 06:52:51.047789 duration_in_ms=114.294
2017-09-19 06:52:51,050 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 06:52:51.050404
2017-09-19 06:52:51,051 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-19 06:52:51,051 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-19 06:52:51,099 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:51,099 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 06:52:51.099395 duration_in_ms=48.991
2017-09-19 06:52:51,100 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:52:51.099883
2017-09-19 06:52:51,100 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-19 06:52:51,101 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-19 06:52:51,148 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:51,148 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:52:51.148185 duration_in_ms=48.302
2017-09-19 06:52:51,149 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:52:51.148601
2017-09-19 06:52:51,149 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-19 06:52:51,149 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-19 06:52:51,201 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:51,201 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:52:51.201205 duration_in_ms=52.604
2017-09-19 06:52:51,202 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 06:52:51.201586
2017-09-19 06:52:51,202 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-19 06:52:51,202 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-19 06:52:51,250 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:51,251 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 06:52:51.250644 duration_in_ms=49.056
2017-09-19 06:52:51,251 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 06:52:51.251169
2017-09-19 06:52:51,251 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-19 06:52:51,252 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-19 06:52:51,299 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:51,299 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 06:52:51.299147 duration_in_ms=47.978
2017-09-19 06:52:51,300 [salt.state       ][INFO    ][31856] Running state [keystone-keys] at time 06:52:51.300093
2017-09-19 06:52:51,300 [salt.state       ][INFO    ][31856] Executing state glusterfs.started for keystone-keys
2017-09-19 06:52:51,301 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:51,309 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:51,357 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:51,365 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:51,418 [salt.state       ][INFO    ][31856] Volume keystone-keys is already started
2017-09-19 06:52:51,419 [salt.state       ][INFO    ][31856] Completed state [keystone-keys] at time 06:52:51.418608 duration_in_ms=118.515
2017-09-19 06:52:51,419 [salt.state       ][INFO    ][31856] Running state [nova_instances] at time 06:52:51.419413
2017-09-19 06:52:51,420 [salt.state       ][INFO    ][31856] Executing state glusterfs.created for nova_instances
2017-09-19 06:52:51,420 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:51,428 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:51,476 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:51,485 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:51,536 [salt.state       ][INFO    ][31856] Volume nova_instances already exists and is started.
2017-09-19 06:52:51,536 [salt.state       ][INFO    ][31856] Completed state [nova_instances] at time 06:52:51.536161 duration_in_ms=116.747
2017-09-19 06:52:51,539 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 06:52:51.539091
2017-09-19 06:52:51,539 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-19 06:52:51,540 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-19 06:52:51,589 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:51,589 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 06:52:51.588971 duration_in_ms=49.88
2017-09-19 06:52:51,589 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 06:52:51.589411
2017-09-19 06:52:51,590 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-09-19 06:52:51,590 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-19 06:52:51,638 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:51,638 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 06:52:51.637957 duration_in_ms=48.546
2017-09-19 06:52:51,638 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 06:52:51.638415
2017-09-19 06:52:51,639 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-09-19 06:52:51,639 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-19 06:52:51,688 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:51,688 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 06:52:51.688333 duration_in_ms=49.918
2017-09-19 06:52:51,689 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 06:52:51.688752
2017-09-19 06:52:51,689 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-09-19 06:52:51,689 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-09-19 06:52:51,737 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:51,738 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 06:52:51.737474 duration_in_ms=48.722
2017-09-19 06:52:51,738 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 06:52:51.737887
2017-09-19 06:52:51,738 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-19 06:52:51,739 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-19 06:52:51,786 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:51,787 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 06:52:51.786652 duration_in_ms=48.764
2017-09-19 06:52:51,788 [salt.state       ][INFO    ][31856] Running state [nova_instances] at time 06:52:51.787594
2017-09-19 06:52:51,788 [salt.state       ][INFO    ][31856] Executing state glusterfs.started for nova_instances
2017-09-19 06:52:51,788 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:51,796 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:51,844 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:51,853 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:51,910 [salt.state       ][INFO    ][31856] Volume nova_instances is already started
2017-09-19 06:52:51,910 [salt.state       ][INFO    ][31856] Completed state [nova_instances] at time 06:52:51.909857 duration_in_ms=122.263
2017-09-19 06:52:51,911 [salt.state       ][INFO    ][31856] Running state [keystone-credential-keys] at time 06:52:51.911174
2017-09-19 06:52:51,911 [salt.state       ][INFO    ][31856] Executing state glusterfs.created for keystone-credential-keys
2017-09-19 06:52:51,912 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:51,921 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:51,969 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:51,977 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:52,028 [salt.state       ][INFO    ][31856] Volume keystone-credential-keys already exists and is started.
2017-09-19 06:52:52,028 [salt.state       ][INFO    ][31856] Completed state [keystone-credential-keys] at time 06:52:52.028276 duration_in_ms=117.101
2017-09-19 06:52:52,032 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 06:52:52.031603
2017-09-19 06:52:52,032 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-19 06:52:52,033 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-19 06:52:52,082 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:52,082 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 06:52:52.082388 duration_in_ms=50.785
2017-09-19 06:52:52,083 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:52:52.082838
2017-09-19 06:52:52,083 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-19 06:52:52,083 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-19 06:52:52,133 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:52,133 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 06:52:52.133454 duration_in_ms=50.615
2017-09-19 06:52:52,134 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 06:52:52.133910
2017-09-19 06:52:52,134 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-19 06:52:52,135 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-19 06:52:52,183 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:52,184 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 06:52:52.183502 duration_in_ms=49.591
2017-09-19 06:52:52,184 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:52:52.183981
2017-09-19 06:52:52,184 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-19 06:52:52,185 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-19 06:52:52,233 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:52,233 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 06:52:52.233435 duration_in_ms=49.453
2017-09-19 06:52:52,234 [salt.state       ][INFO    ][31856] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 06:52:52.233858
2017-09-19 06:52:52,234 [salt.state       ][INFO    ][31856] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-19 06:52:52,234 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-19 06:52:52,281 [salt.state       ][INFO    ][31856] unless execution succeeded
2017-09-19 06:52:52,282 [salt.state       ][INFO    ][31856] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 06:52:52.281683 duration_in_ms=47.824
2017-09-19 06:52:52,283 [salt.state       ][INFO    ][31856] Running state [keystone-credential-keys] at time 06:52:52.282592
2017-09-19 06:52:52,283 [salt.state       ][INFO    ][31856] Executing state glusterfs.started for keystone-credential-keys
2017-09-19 06:52:52,283 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:52,291 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:52,339 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --version' in directory '/root'
2017-09-19 06:52:52,348 [salt.loaded.int.module.cmdmod][INFO    ][31856] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 06:52:52,400 [salt.state       ][INFO    ][31856] Volume keystone-credential-keys is already started
2017-09-19 06:52:52,400 [salt.state       ][INFO    ][31856] Completed state [keystone-credential-keys] at time 06:52:52.399825 duration_in_ms=117.231
2017-09-19 06:52:52,402 [salt.minion      ][INFO    ][31856] Returning information for job: 20170919065247575266
2017-09-19 06:52:57,337 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command test.ping with jid 20170919065257327510
2017-09-19 06:52:57,352 [salt.minion      ][INFO    ][32282] Starting a new job with PID 32282
2017-09-19 06:52:57,377 [salt.minion      ][INFO    ][32282] Returning information for job: 20170919065257327510
2017-09-19 06:52:57,783 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command cmd.run with jid 20170919065257775015
2017-09-19 06:52:57,798 [salt.minion      ][INFO    ][32287] Starting a new job with PID 32287
2017-09-19 06:52:57,802 [salt.loaded.int.module.cmdmod][INFO    ][32287] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-19 06:52:57,917 [salt.minion      ][INFO    ][32287] Returning information for job: 20170919065257775015
2017-09-19 07:22:11,981 [salt.utils.schedule][INFO    ][24007] Running scheduled job: __mine_interval
2017-09-19 08:17:01,262 [salt.minion      ][INFO    ][24007] User sudo_ubuntu Executing command cp.push_dir with jid 20170919081701256839
2017-09-19 08:17:01,282 [salt.minion      ][INFO    ][1189] Starting a new job with PID 1189
