2017-12-01 08:02:09,356 [salt.cli.daemons ][WARNING ][2465] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-01 08:19:29,713 [salt.state       ][ERROR   ][3761] No contents found in top file
2017-12-01 08:22:41,668 [salt.utils.parsers][WARNING ][2465] Minion received a SIGTERM. Exiting.
2017-12-01 08:25:07,642 [salt.cli.daemons ][WARNING ][3264] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-01 08:28:22,429 [py.warnings      ][WARNING ][14200] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-12-01 08:29:57,373 [salt.loaded.int.module.cmdmod][ERROR   ][14200] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-01 08:29:57,374 [salt.loaded.int.module.cmdmod][ERROR   ][14200] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-01 08:30:05,884 [salt.loaded.int.module.cmdmod][ERROR   ][14200] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-01 08:30:05,885 [salt.loaded.int.module.cmdmod][ERROR   ][14200] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-01 08:30:15,433 [salt.loaded.int.module.cmdmod][ERROR   ][14200] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-01 08:30:15,434 [salt.loaded.int.module.cmdmod][ERROR   ][14200] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-01 08:30:25,022 [salt.loaded.int.module.cmdmod][ERROR   ][14200] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-01 08:30:25,022 [salt.loaded.int.module.cmdmod][ERROR   ][14200] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-01 08:30:34,351 [salt.loaded.int.module.cmdmod][ERROR   ][14200] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-01 08:30:34,351 [salt.loaded.int.module.cmdmod][ERROR   ][14200] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-01 08:30:41,034 [salt.loaded.int.module.cmdmod][ERROR   ][14200] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-12-01 08:30:43,171 [salt.loaded.int.module.cmdmod][INFO    ][21658] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-01 08:30:43,178 [salt.loaded.int.module.cmdmod][INFO    ][21658] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-01 08:30:43,188 [salt.loaded.int.module.cmdmod][INFO    ][21658] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-01 08:30:43,195 [salt.utils.parsers][WARNING ][3264] Minion received a SIGTERM. Exiting.
2017-12-01 08:30:43,454 [salt.cli.daemons ][INFO    ][21731] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-12-01 08:30:43,957 [salt.minion      ][INFO    ][21731] Creating minion process manager
2017-12-01 08:30:43,957 [salt.cli.daemons ][WARNING ][21731] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-01 08:30:43,957 [salt.cli.daemons ][INFO    ][21731] The Salt Minion is starting up
2017-12-01 08:30:43,957 [salt.minion      ][INFO    ][21731] Minion is starting as user 'root'
2017-12-01 08:30:43,958 [salt.utils.event ][INFO    ][21731] Starting pull socket on /var/run/salt/minion/minion_event_0fd62c7a6e_pull.ipc
2017-12-01 08:30:44,783 [salt.loaded.int.module.cmdmod][INFO    ][21731] Executing command ['date', '+%z'] in directory '/root'
2017-12-01 08:30:44,895 [salt.utils.schedule][INFO    ][21731] Updating job settings for scheduled job: __mine_interval
2017-12-01 08:30:44,897 [salt.minion      ][INFO    ][21731] Added mine.update to scheduler
2017-12-01 08:30:45,046 [salt.minion      ][INFO    ][21731] Minion is ready to receive requests!
2017-12-01 08:30:46,048 [salt.utils.schedule][INFO    ][21731] Running scheduled job: __mine_interval
2017-12-01 08:32:04,193 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171201083204186658
2017-12-01 08:32:04,206 [salt.minion      ][INFO    ][21851] Starting a new job with PID 21851
2017-12-01 08:32:06,089 [salt.state       ][INFO    ][21851] Loading fresh modules for state activity
2017-12-01 08:32:06,113 [salt.state       ][ERROR   ][21851] No contents found in top file
2017-12-01 08:32:06,114 [salt.utils.extmods][INFO    ][21851] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-01 08:32:06,117 [salt.utils.extmods][INFO    ][21851] Syncing beacons for environment 'base'
2017-12-01 08:32:06,117 [salt.utils.extmods][INFO    ][21851] Loading cache from salt://_beacons, for base)
2017-12-01 08:32:06,117 [salt.fileclient  ][INFO    ][21851] Caching directory '_beacons/' for environment 'base'
2017-12-01 08:32:06,144 [salt.utils.extmods][INFO    ][21851] Syncing modules for environment 'base'
2017-12-01 08:32:06,144 [salt.utils.extmods][INFO    ][21851] Loading cache from salt://_modules, for base)
2017-12-01 08:32:06,144 [salt.fileclient  ][INFO    ][21851] Caching directory '_modules/' for environment 'base'
2017-12-01 08:32:06,276 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-01 08:32:06,342 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-01 08:32:06,401 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-01 08:32:06,420 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-01 08:32:06,515 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-01 08:32:06,581 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-01 08:32:06,590 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-01 08:32:06,612 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-01 08:32:06,791 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-01 08:32:06,941 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-01 08:32:07,087 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-01 08:32:07,265 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-01 08:32:07,422 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-01 08:32:07,434 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-01 08:32:07,535 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-01 08:32:07,598 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-01 08:32:07,618 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-01 08:32:07,631 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-01 08:32:07,644 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-01 08:32:07,660 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-01 08:32:07,682 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-01 08:32:07,693 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-01 08:32:07,713 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-01 08:32:07,725 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-01 08:32:07,737 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-01 08:32:07,748 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-01 08:32:07,763 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-01 08:32:07,774 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-01 08:32:07,795 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-01 08:32:07,814 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-01 08:32:07,825 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-01 08:32:07,836 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-01 08:32:07,847 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-01 08:32:07,868 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-01 08:32:07,871 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-01 08:32:07,872 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-01 08:32:07,877 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-01 08:32:07,878 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-01 08:32:07,878 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-01 08:32:07,885 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-01 08:32:07,885 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-01 08:32:07,886 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-01 08:32:07,886 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-01 08:32:07,887 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-01 08:32:07,893 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-01 08:32:07,894 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-01 08:32:07,895 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-01 08:32:07,895 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-01 08:32:07,896 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-01 08:32:07,896 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-01 08:32:07,897 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-01 08:32:07,897 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-01 08:32:07,898 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-01 08:32:07,898 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-01 08:32:07,899 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-01 08:32:07,900 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-01 08:32:07,901 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-01 08:32:07,902 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-01 08:32:07,903 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-01 08:32:07,903 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-01 08:32:07,904 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-01 08:32:07,904 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-01 08:32:07,905 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-01 08:32:07,906 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-01 08:32:07,909 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-01 08:32:07,909 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-01 08:32:07,909 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-01 08:32:07,910 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-12-01 08:32:07,910 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-01 08:32:07,911 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-01 08:32:07,916 [salt.utils.extmods][INFO    ][21851] Syncing states for environment 'base'
2017-12-01 08:32:07,916 [salt.utils.extmods][INFO    ][21851] Loading cache from salt://_states, for base)
2017-12-01 08:32:07,916 [salt.fileclient  ][INFO    ][21851] Caching directory '_states/' for environment 'base'
2017-12-01 08:32:07,944 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-01 08:32:07,962 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-01 08:32:07,973 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-01 08:32:07,985 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-01 08:32:08,291 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-01 08:32:08,309 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-01 08:32:08,334 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-01 08:32:08,353 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-01 08:32:08,364 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-01 08:32:08,375 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-01 08:32:08,387 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-01 08:32:08,397 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-01 08:32:08,408 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-01 08:32:08,419 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-01 08:32:08,444 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-01 08:32:08,461 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-01 08:32:08,473 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-01 08:32:08,485 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-01 08:32:08,497 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-01 08:32:08,509 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-01 08:32:08,530 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-01 08:32:08,541 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-01 08:32:08,560 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-01 08:32:08,573 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-01 08:32:08,585 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-01 08:32:08,597 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-01 08:32:08,620 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-01 08:32:08,632 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-01 08:32:08,644 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-01 08:32:08,656 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-01 08:32:08,668 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-01 08:32:08,679 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-01 08:32:08,682 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-01 08:32:08,682 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-01 08:32:08,682 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-01 08:32:08,683 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-01 08:32:08,683 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-01 08:32:08,683 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-01 08:32:08,684 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-01 08:32:08,684 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-01 08:32:08,684 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-01 08:32:08,684 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-01 08:32:08,685 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-01 08:32:08,685 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-01 08:32:08,685 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-01 08:32:08,685 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-01 08:32:08,686 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-01 08:32:08,686 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-01 08:32:08,686 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-01 08:32:08,686 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-01 08:32:08,687 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-01 08:32:08,687 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-01 08:32:08,687 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-01 08:32:08,687 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-01 08:32:08,688 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-01 08:32:08,688 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-01 08:32:08,688 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-01 08:32:08,688 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-01 08:32:08,689 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-01 08:32:08,689 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-01 08:32:08,689 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-01 08:32:08,689 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-01 08:32:08,690 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-01 08:32:08,690 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-01 08:32:08,690 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-01 08:32:08,692 [salt.utils.extmods][INFO    ][21851] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-01 08:32:08,695 [salt.utils.extmods][INFO    ][21851] Syncing sdb for environment 'base'
2017-12-01 08:32:08,695 [salt.utils.extmods][INFO    ][21851] Loading cache from salt://_sdb, for base)
2017-12-01 08:32:08,695 [salt.fileclient  ][INFO    ][21851] Caching directory '_sdb/' for environment 'base'
2017-12-01 08:32:08,731 [salt.utils.extmods][INFO    ][21851] Syncing grains for environment 'base'
2017-12-01 08:32:08,731 [salt.utils.extmods][INFO    ][21851] Loading cache from salt://_grains, for base)
2017-12-01 08:32:08,731 [salt.fileclient  ][INFO    ][21851] Caching directory '_grains/' for environment 'base'
2017-12-01 08:32:08,771 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-01 08:32:08,783 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-01 08:32:08,793 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-01 08:32:08,804 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-01 08:32:08,816 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-01 08:32:08,826 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-01 08:32:08,836 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-01 08:32:08,846 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-01 08:32:08,857 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-01 08:32:08,867 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-01 08:32:08,876 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-01 08:32:09,189 [salt.fileclient  ][INFO    ][21851] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-01 08:32:09,192 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-01 08:32:09,193 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-01 08:32:09,193 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-01 08:32:09,193 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-01 08:32:09,194 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-01 08:32:09,194 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-01 08:32:09,194 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-01 08:32:09,195 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-01 08:32:09,196 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-01 08:32:09,196 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-01 08:32:09,196 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-01 08:32:09,196 [salt.utils.extmods][INFO    ][21851] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-01 08:32:09,198 [salt.utils.extmods][INFO    ][21851] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-01 08:32:09,201 [salt.utils.extmods][INFO    ][21851] Syncing renderers for environment 'base'
2017-12-01 08:32:09,201 [salt.utils.extmods][INFO    ][21851] Loading cache from salt://_renderers, for base)
2017-12-01 08:32:09,201 [salt.fileclient  ][INFO    ][21851] Caching directory '_renderers/' for environment 'base'
2017-12-01 08:32:09,225 [salt.utils.extmods][INFO    ][21851] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-01 08:32:09,228 [salt.utils.extmods][INFO    ][21851] Syncing returners for environment 'base'
2017-12-01 08:32:09,228 [salt.utils.extmods][INFO    ][21851] Loading cache from salt://_returners, for base)
2017-12-01 08:32:09,228 [salt.fileclient  ][INFO    ][21851] Caching directory '_returners/' for environment 'base'
2017-12-01 08:32:09,248 [salt.utils.extmods][INFO    ][21851] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-01 08:32:09,250 [salt.utils.extmods][INFO    ][21851] Syncing output for environment 'base'
2017-12-01 08:32:09,250 [salt.utils.extmods][INFO    ][21851] Loading cache from salt://_output, for base)
2017-12-01 08:32:09,250 [salt.fileclient  ][INFO    ][21851] Caching directory '_output/' for environment 'base'
2017-12-01 08:32:09,270 [salt.utils.extmods][INFO    ][21851] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-01 08:32:09,273 [salt.utils.extmods][INFO    ][21851] Syncing utils for environment 'base'
2017-12-01 08:32:09,273 [salt.utils.extmods][INFO    ][21851] Loading cache from salt://_utils, for base)
2017-12-01 08:32:09,273 [salt.fileclient  ][INFO    ][21851] Caching directory '_utils/' for environment 'base'
2017-12-01 08:32:09,300 [salt.utils.extmods][INFO    ][21851] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-01 08:32:09,302 [salt.utils.extmods][INFO    ][21851] Syncing log_handlers for environment 'base'
2017-12-01 08:32:09,302 [salt.utils.extmods][INFO    ][21851] Loading cache from salt://_log_handlers, for base)
2017-12-01 08:32:09,302 [salt.fileclient  ][INFO    ][21851] Caching directory '_log_handlers/' for environment 'base'
2017-12-01 08:32:09,327 [salt.utils.extmods][INFO    ][21851] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-01 08:32:09,329 [salt.utils.extmods][INFO    ][21851] Syncing proxy for environment 'base'
2017-12-01 08:32:09,329 [salt.utils.extmods][INFO    ][21851] Loading cache from salt://_proxy, for base)
2017-12-01 08:32:09,329 [salt.fileclient  ][INFO    ][21851] Caching directory '_proxy/' for environment 'base'
2017-12-01 08:32:09,361 [salt.utils.extmods][INFO    ][21851] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-01 08:32:09,363 [salt.utils.extmods][INFO    ][21851] Syncing engines for environment 'base'
2017-12-01 08:32:09,363 [salt.utils.extmods][INFO    ][21851] Loading cache from salt://_engines, for base)
2017-12-01 08:32:09,364 [salt.fileclient  ][INFO    ][21851] Caching directory '_engines/' for environment 'base'
2017-12-01 08:32:09,389 [salt.minion      ][INFO    ][21851] Returning information for job: 20171201083204186658
2017-12-01 08:32:14,485 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command state.sls with jid 20171201083214483752
2017-12-01 08:32:14,497 [salt.minion      ][INFO    ][21954] Starting a new job with PID 21954
2017-12-01 08:32:14,928 [salt.state       ][INFO    ][21954] Loading fresh modules for state activity
2017-12-01 08:32:14,957 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-01 08:32:14,976 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-01 08:32:15,069 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 08:32:15,138 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-01 08:32:15,154 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-01 08:32:15,177 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 08:32:15,229 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-01 08:32:15,245 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:32:15,286 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-01 08:32:15,302 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-01 08:32:15,314 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-01 08:32:15,326 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-01 08:32:15,333 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-01 08:32:15,354 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-01 08:32:15,370 [py.warnings      ][WARNING ][21954] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-12-01 08:32:15,370 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'salt-minion --version' in directory '/root'
2017-12-01 08:32:15,612 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-01 08:32:15,630 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-01 08:32:15,642 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-01 08:32:15,653 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-01 08:32:15,687 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-01 08:32:15,701 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-01 08:32:15,721 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-01 08:32:15,734 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-01 08:32:15,749 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-01 08:32:15,783 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-01 08:32:15,841 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-01 08:32:15,860 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 08:32:15,917 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-01 08:32:15,935 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:32:15,977 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-01 08:32:15,994 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-01 08:32:16,006 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-01 08:32:16,022 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-01 08:32:16,028 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-01 08:32:16,048 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-01 08:32:16,062 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'salt-minion --version' in directory '/root'
2017-12-01 08:32:16,324 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-01 08:32:16,343 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-01 08:32:16,355 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-01 08:32:16,381 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-01 08:32:16,417 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-01 08:32:16,431 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-01 08:32:16,454 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-01 08:32:16,468 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-01 08:32:16,484 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-01 08:32:16,517 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-01 08:32:16,583 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-01 08:32:16,637 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 08:32:16,994 [salt.state       ][INFO    ][21954] Running state [salt-minion] at time 08:32:16.993632
2017-12-01 08:32:16,994 [salt.state       ][INFO    ][21954] Executing state pkg.installed for salt-minion
2017-12-01 08:32:16,994 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:32:17,247 [salt.state       ][INFO    ][21954] Package salt-minion is already installed
2017-12-01 08:32:17,247 [salt.state       ][INFO    ][21954] Completed state [salt-minion] at time 08:32:17.247259 duration_in_ms=253.627
2017-12-01 08:32:17,248 [salt.state       ][INFO    ][21954] Running state [salt_minion_dependency_packages] at time 08:32:17.247487
2017-12-01 08:32:17,248 [salt.state       ][INFO    ][21954] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-01 08:32:17,250 [salt.state       ][INFO    ][21954] All specified packages are already installed
2017-12-01 08:32:17,251 [salt.state       ][INFO    ][21954] Completed state [salt_minion_dependency_packages] at time 08:32:17.250486 duration_in_ms=2.999
2017-12-01 08:32:17,252 [salt.state       ][INFO    ][21954] Running state [/etc/salt/minion.d/minion.conf] at time 08:32:17.251964
2017-12-01 08:32:17,252 [salt.state       ][INFO    ][21954] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-01 08:32:17,272 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-01 08:32:17,317 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 08:32:17,359 [salt.fileclient  ][INFO    ][21954] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:32:17,392 [salt.state       ][INFO    ][21954] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-01 08:32:17,392 [salt.state       ][INFO    ][21954] Completed state [/etc/salt/minion.d/minion.conf] at time 08:32:17.392238 duration_in_ms=140.275
2017-12-01 08:32:17,393 [salt.state       ][INFO    ][21954] Running state [/etc/salt/minion.d/_virt.conf] at time 08:32:17.392524
2017-12-01 08:32:17,393 [salt.state       ][INFO    ][21954] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-01 08:32:17,395 [salt.state       ][INFO    ][21954] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-01 08:32:17,396 [salt.state       ][INFO    ][21954] Completed state [/etc/salt/minion.d/_virt.conf] at time 08:32:17.395521 duration_in_ms=2.996
2017-12-01 08:32:17,397 [salt.state       ][INFO    ][21954] Running state [salt-minion] at time 08:32:17.396831
2017-12-01 08:32:17,397 [salt.state       ][INFO    ][21954] Executing state service.running for salt-minion
2017-12-01 08:32:17,397 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-01 08:32:17,408 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-01 08:32:17,413 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-01 08:32:17,418 [salt.state       ][INFO    ][21954] The service salt-minion is already running
2017-12-01 08:32:17,418 [salt.state       ][INFO    ][21954] Completed state [salt-minion] at time 08:32:17.418370 duration_in_ms=21.538
2017-12-01 08:32:17,420 [salt.state       ][INFO    ][21954] Running state [/etc/salt/grains.d] at time 08:32:17.419529
2017-12-01 08:32:17,420 [salt.state       ][INFO    ][21954] Executing state file.directory for /etc/salt/grains.d
2017-12-01 08:32:17,420 [salt.state       ][INFO    ][21954] Directory /etc/salt/grains.d is in the correct state
2017-12-01 08:32:17,420 [salt.state       ][INFO    ][21954] Completed state [/etc/salt/grains.d] at time 08:32:17.420342 duration_in_ms=0.813
2017-12-01 08:32:17,421 [salt.state       ][INFO    ][21954] Running state [/etc/salt/grains] at time 08:32:17.420749
2017-12-01 08:32:17,421 [salt.state       ][INFO    ][21954] Executing state file.managed for /etc/salt/grains
2017-12-01 08:32:17,421 [salt.state       ][INFO    ][21954] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-01 08:32:17,421 [salt.state       ][INFO    ][21954] Completed state [/etc/salt/grains] at time 08:32:17.421361 duration_in_ms=0.612
2017-12-01 08:32:17,422 [salt.state       ][INFO    ][21954] Running state [/etc/salt/grains.d/placeholder] at time 08:32:17.421620
2017-12-01 08:32:17,422 [salt.state       ][INFO    ][21954] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-01 08:32:17,422 [salt.state       ][INFO    ][21954] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-01 08:32:17,422 [salt.state       ][INFO    ][21954] Completed state [/etc/salt/grains.d/placeholder] at time 08:32:17.422233 duration_in_ms=0.612
2017-12-01 08:32:17,423 [salt.state       ][INFO    ][21954] Running state [/etc/salt/grains.d/sphinx] at time 08:32:17.422500
2017-12-01 08:32:17,423 [salt.state       ][INFO    ][21954] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-01 08:32:17,426 [salt.state       ][INFO    ][21954] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.141
               - 127.0.0.1
               - 192.168.11.251
-              - 192.168.122.1
         system:
           name: System
           param:

2017-12-01 08:32:17,426 [salt.state       ][INFO    ][21954] Completed state [/etc/salt/grains.d/sphinx] at time 08:32:17.425658 duration_in_ms=3.158
2017-12-01 08:32:17,426 [salt.state       ][INFO    ][21954] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:32:17.426263
2017-12-01 08:32:17,426 [salt.state       ][INFO    ][21954] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-01 08:32:17,427 [salt.state       ][INFO    ][21954] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-01 08:32:17,427 [salt.state       ][INFO    ][21954] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:32:17.426744 duration_in_ms=0.482
2017-12-01 08:32:17,427 [salt.state       ][INFO    ][21954] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:32:17.426880
2017-12-01 08:32:17,427 [salt.state       ][INFO    ][21954] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-01 08:32:17,428 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-12-01 08:32:17,501 [salt.state       ][INFO    ][21954] {'pid': 22002, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-01 08:32:17,502 [salt.state       ][INFO    ][21954] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:32:17.501720 duration_in_ms=74.84
2017-12-01 08:32:17,502 [salt.state       ][INFO    ][21954] Running state [/etc/salt/grains.d/dns_records] at time 08:32:17.502161
2017-12-01 08:32:17,502 [salt.state       ][INFO    ][21954] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-01 08:32:17,509 [salt.state       ][INFO    ][21954] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-01 08:32:17,510 [salt.state       ][INFO    ][21954] Completed state [/etc/salt/grains.d/dns_records] at time 08:32:17.509470 duration_in_ms=7.309
2017-12-01 08:32:17,510 [salt.state       ][INFO    ][21954] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:32:17.510125
2017-12-01 08:32:17,510 [salt.state       ][INFO    ][21954] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-01 08:32:17,511 [salt.state       ][INFO    ][21954] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-01 08:32:17,511 [salt.state       ][INFO    ][21954] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:32:17.510626 duration_in_ms=0.501
2017-12-01 08:32:17,511 [salt.state       ][INFO    ][21954] Running state [/etc/salt/grains.d/salt] at time 08:32:17.510892
2017-12-01 08:32:17,511 [salt.state       ][INFO    ][21954] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-01 08:32:17,517 [salt.state       ][INFO    ][21954] File /etc/salt/grains.d/salt is in the correct state
2017-12-01 08:32:17,517 [salt.state       ][INFO    ][21954] Completed state [/etc/salt/grains.d/salt] at time 08:32:17.517352 duration_in_ms=6.46
2017-12-01 08:32:17,518 [salt.state       ][INFO    ][21954] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:32:17.517880
2017-12-01 08:32:17,518 [salt.state       ][INFO    ][21954] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-01 08:32:17,518 [salt.state       ][INFO    ][21954] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-01 08:32:17,518 [salt.state       ][INFO    ][21954] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:32:17.518386 duration_in_ms=0.505
2017-12-01 08:32:17,520 [salt.state       ][INFO    ][21954] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:32:17.519509
2017-12-01 08:32:17,520 [salt.state       ][INFO    ][21954] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-01 08:32:17,520 [salt.state       ][INFO    ][21954] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-01 08:32:17,520 [salt.state       ][INFO    ][21954] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:32:17.520010 duration_in_ms=0.5
2017-12-01 08:32:17,520 [salt.state       ][INFO    ][21954] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:32:17.520139
2017-12-01 08:32:17,520 [salt.state       ][INFO    ][21954] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-01 08:32:17,521 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-12-01 08:32:17,529 [salt.state       ][INFO    ][21954] {'pid': 22004, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-01 08:32:17,529 [salt.state       ][INFO    ][21954] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:32:17.528881 duration_in_ms=8.74
2017-12-01 08:32:17,530 [salt.state       ][INFO    ][21954] Running state [mine.update] at time 08:32:17.529556
2017-12-01 08:32:17,530 [salt.state       ][INFO    ][21954] Executing state module.wait for mine.update
2017-12-01 08:32:17,530 [salt.state       ][INFO    ][21954] No changes made for mine.update
2017-12-01 08:32:17,530 [salt.state       ][INFO    ][21954] Completed state [mine.update] at time 08:32:17.530245 duration_in_ms=0.689
2017-12-01 08:32:17,530 [salt.state       ][INFO    ][21954] Running state [mine.update] at time 08:32:17.530413
2017-12-01 08:32:17,531 [salt.state       ][INFO    ][21954] Executing state module.mod_watch for mine.update
2017-12-01 08:32:18,050 [salt.state       ][INFO    ][21954] {'ret': True}
2017-12-01 08:32:18,051 [salt.state       ][INFO    ][21954] Completed state [mine.update] at time 08:32:18.050520 duration_in_ms=520.107
2017-12-01 08:32:18,051 [salt.state       ][INFO    ][21954] Running state [ca-certificates] at time 08:32:18.050758
2017-12-01 08:32:18,051 [salt.state       ][INFO    ][21954] Executing state pkg.installed for ca-certificates
2017-12-01 08:32:18,054 [salt.state       ][INFO    ][21954] Package ca-certificates is already installed
2017-12-01 08:32:18,055 [salt.state       ][INFO    ][21954] Completed state [ca-certificates] at time 08:32:18.054516 duration_in_ms=3.758
2017-12-01 08:32:18,055 [salt.state       ][INFO    ][21954] Running state [update-ca-certificates] at time 08:32:18.055070
2017-12-01 08:32:18,055 [salt.state       ][INFO    ][21954] Executing state cmd.wait for update-ca-certificates
2017-12-01 08:32:18,056 [salt.state       ][INFO    ][21954] No changes made for update-ca-certificates
2017-12-01 08:32:18,056 [salt.state       ][INFO    ][21954] Completed state [update-ca-certificates] at time 08:32:18.055712 duration_in_ms=0.642
2017-12-01 08:32:18,056 [salt.state       ][INFO    ][21954] Running state [libvirt-dev] at time 08:32:18.055913
2017-12-01 08:32:18,056 [salt.state       ][INFO    ][21954] Executing state pkg.installed for libvirt-dev
2017-12-01 08:32:18,059 [salt.state       ][INFO    ][21954] Package libvirt-dev is already installed
2017-12-01 08:32:18,059 [salt.state       ][INFO    ][21954] Completed state [libvirt-dev] at time 08:32:18.059087 duration_in_ms=3.174
2017-12-01 08:32:18,059 [salt.state       ][INFO    ][21954] Running state [pkg-config] at time 08:32:18.059284
2017-12-01 08:32:18,059 [salt.state       ][INFO    ][21954] Executing state pkg.installed for pkg-config
2017-12-01 08:32:18,062 [salt.state       ][INFO    ][21954] Package pkg-config is already installed
2017-12-01 08:32:18,062 [salt.state       ][INFO    ][21954] Completed state [pkg-config] at time 08:32:18.062459 duration_in_ms=3.175
2017-12-01 08:32:18,063 [salt.state       ][INFO    ][21954] Running state [virtng.init] at time 08:32:18.062664
2017-12-01 08:32:18,063 [salt.state       ][INFO    ][21954] Executing state module.run for virtng.init
2017-12-01 08:32:18,171 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command ['git', '--version'] in directory '/root'
2017-12-01 08:32:18,222 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:18,242 [salt.state       ][INFO    ][21954] unless execution succeeded
2017-12-01 08:32:18,242 [salt.state       ][INFO    ][21954] Completed state [virtng.init] at time 08:32:18.241991 duration_in_ms=179.327
2017-12-01 08:32:18,242 [salt.state       ][INFO    ][21954] Running state [virt.set_autostart] at time 08:32:18.242273
2017-12-01 08:32:18,243 [salt.state       ][INFO    ][21954] Executing state module.run for virt.set_autostart
2017-12-01 08:32:18,245 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:18,262 [salt.state       ][INFO    ][21954] unless execution succeeded
2017-12-01 08:32:18,262 [salt.state       ][INFO    ][21954] Completed state [virt.set_autostart] at time 08:32:18.261780 duration_in_ms=19.507
2017-12-01 08:32:18,262 [salt.state       ][INFO    ][21954] Running state [virtng.init] at time 08:32:18.262011
2017-12-01 08:32:18,262 [salt.state       ][INFO    ][21954] Executing state module.run for virtng.init
2017-12-01 08:32:18,264 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:18,279 [salt.state       ][INFO    ][21954] unless execution succeeded
2017-12-01 08:32:18,279 [salt.state       ][INFO    ][21954] Completed state [virtng.init] at time 08:32:18.279391 duration_in_ms=17.38
2017-12-01 08:32:18,280 [salt.state       ][INFO    ][21954] Running state [virt.set_autostart] at time 08:32:18.279645
2017-12-01 08:32:18,280 [salt.state       ][INFO    ][21954] Executing state module.run for virt.set_autostart
2017-12-01 08:32:18,282 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:18,298 [salt.state       ][INFO    ][21954] unless execution succeeded
2017-12-01 08:32:18,298 [salt.state       ][INFO    ][21954] Completed state [virt.set_autostart] at time 08:32:18.298000 duration_in_ms=18.355
2017-12-01 08:32:18,298 [salt.state       ][INFO    ][21954] Running state [virtng.init] at time 08:32:18.298216
2017-12-01 08:32:18,298 [salt.state       ][INFO    ][21954] Executing state module.run for virtng.init
2017-12-01 08:32:18,300 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:18,316 [salt.state       ][INFO    ][21954] unless execution succeeded
2017-12-01 08:32:18,316 [salt.state       ][INFO    ][21954] Completed state [virtng.init] at time 08:32:18.315886 duration_in_ms=17.669
2017-12-01 08:32:18,316 [salt.state       ][INFO    ][21954] Running state [virt.set_autostart] at time 08:32:18.316154
2017-12-01 08:32:18,316 [salt.state       ][INFO    ][21954] Executing state module.run for virt.set_autostart
2017-12-01 08:32:18,318 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:18,334 [salt.state       ][INFO    ][21954] unless execution succeeded
2017-12-01 08:32:18,334 [salt.state       ][INFO    ][21954] Completed state [virt.set_autostart] at time 08:32:18.334309 duration_in_ms=18.154
2017-12-01 08:32:18,335 [salt.state       ][INFO    ][21954] Running state [virtng.init] at time 08:32:18.334528
2017-12-01 08:32:18,335 [salt.state       ][INFO    ][21954] Executing state module.run for virtng.init
2017-12-01 08:32:18,337 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:18,351 [salt.state       ][INFO    ][21954] unless execution succeeded
2017-12-01 08:32:18,351 [salt.state       ][INFO    ][21954] Completed state [virtng.init] at time 08:32:18.351024 duration_in_ms=16.497
2017-12-01 08:32:18,351 [salt.state       ][INFO    ][21954] Running state [virt.set_autostart] at time 08:32:18.351290
2017-12-01 08:32:18,352 [salt.state       ][INFO    ][21954] Executing state module.run for virt.set_autostart
2017-12-01 08:32:18,353 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:18,368 [salt.state       ][INFO    ][21954] unless execution succeeded
2017-12-01 08:32:18,368 [salt.state       ][INFO    ][21954] Completed state [virt.set_autostart] at time 08:32:18.367999 duration_in_ms=16.71
2017-12-01 08:32:18,368 [salt.state       ][INFO    ][21954] Running state [virtng.init] at time 08:32:18.368201
2017-12-01 08:32:18,368 [salt.state       ][INFO    ][21954] Executing state module.run for virtng.init
2017-12-01 08:32:18,370 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:18,384 [salt.state       ][INFO    ][21954] unless execution succeeded
2017-12-01 08:32:18,384 [salt.state       ][INFO    ][21954] Completed state [virtng.init] at time 08:32:18.384217 duration_in_ms=16.015
2017-12-01 08:32:18,384 [salt.state       ][INFO    ][21954] Running state [virt.set_autostart] at time 08:32:18.384448
2017-12-01 08:32:18,385 [salt.state       ][INFO    ][21954] Executing state module.run for virt.set_autostart
2017-12-01 08:32:18,387 [salt.loaded.int.module.cmdmod][INFO    ][21954] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:18,399 [salt.state       ][INFO    ][21954] unless execution succeeded
2017-12-01 08:32:18,399 [salt.state       ][INFO    ][21954] Completed state [virt.set_autostart] at time 08:32:18.398965 duration_in_ms=14.518
2017-12-01 08:32:18,401 [salt.minion      ][INFO    ][21954] Returning information for job: 20171201083214483752
2017-12-01 08:32:45,603 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command state.sls with jid 20171201083245585762
2017-12-01 08:32:45,616 [salt.minion      ][INFO    ][22065] Starting a new job with PID 22065
2017-12-01 08:32:47,272 [salt.state       ][INFO    ][22065] Loading fresh modules for state activity
2017-12-01 08:32:47,298 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-01 08:32:47,317 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-01 08:32:47,386 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 08:32:47,454 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-01 08:32:47,470 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-01 08:32:47,497 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 08:32:47,555 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-01 08:32:47,574 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:32:47,618 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-01 08:32:47,637 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-01 08:32:47,707 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-01 08:32:47,726 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-01 08:32:47,733 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-01 08:32:47,755 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-01 08:32:47,769 [py.warnings      ][WARNING ][22065] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-12-01 08:32:47,770 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'salt-minion --version' in directory '/root'
2017-12-01 08:32:48,012 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-01 08:32:48,029 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-01 08:32:48,042 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-01 08:32:48,054 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-01 08:32:48,087 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-01 08:32:48,099 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-01 08:32:48,118 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-01 08:32:48,140 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-01 08:32:48,155 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-01 08:32:48,187 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-01 08:32:48,242 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-01 08:32:48,264 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 08:32:48,318 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-01 08:32:48,335 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:32:48,378 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-01 08:32:48,395 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-01 08:32:48,408 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-01 08:32:48,422 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-01 08:32:48,428 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-01 08:32:48,449 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-01 08:32:48,465 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'salt-minion --version' in directory '/root'
2017-12-01 08:32:48,718 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-01 08:32:48,737 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-01 08:32:48,750 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-01 08:32:48,762 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-01 08:32:48,798 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-01 08:32:48,814 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-01 08:32:48,837 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-01 08:32:48,851 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-01 08:32:48,871 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-01 08:32:48,905 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-01 08:32:48,972 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-01 08:32:49,028 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 08:32:49,333 [salt.state       ][INFO    ][22065] Running state [salt-minion] at time 08:32:49.333444
2017-12-01 08:32:49,334 [salt.state       ][INFO    ][22065] Executing state pkg.installed for salt-minion
2017-12-01 08:32:49,334 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:32:49,620 [salt.state       ][INFO    ][22065] Package salt-minion is already installed
2017-12-01 08:32:49,620 [salt.state       ][INFO    ][22065] Completed state [salt-minion] at time 08:32:49.620318 duration_in_ms=286.875
2017-12-01 08:32:49,621 [salt.state       ][INFO    ][22065] Running state [salt_minion_dependency_packages] at time 08:32:49.620637
2017-12-01 08:32:49,621 [salt.state       ][INFO    ][22065] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-01 08:32:49,624 [salt.state       ][INFO    ][22065] All specified packages are already installed
2017-12-01 08:32:49,624 [salt.state       ][INFO    ][22065] Completed state [salt_minion_dependency_packages] at time 08:32:49.623909 duration_in_ms=3.272
2017-12-01 08:32:49,626 [salt.state       ][INFO    ][22065] Running state [/etc/salt/minion.d/minion.conf] at time 08:32:49.625527
2017-12-01 08:32:49,626 [salt.state       ][INFO    ][22065] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-01 08:32:49,648 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-01 08:32:49,695 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 08:32:49,738 [salt.fileclient  ][INFO    ][22065] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:32:49,772 [salt.state       ][INFO    ][22065] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-01 08:32:49,772 [salt.state       ][INFO    ][22065] Completed state [/etc/salt/minion.d/minion.conf] at time 08:32:49.772232 duration_in_ms=146.705
2017-12-01 08:32:49,773 [salt.state       ][INFO    ][22065] Running state [/etc/salt/minion.d/_virt.conf] at time 08:32:49.772582
2017-12-01 08:32:49,773 [salt.state       ][INFO    ][22065] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-01 08:32:49,779 [salt.state       ][INFO    ][22065] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-01 08:32:49,779 [salt.state       ][INFO    ][22065] Completed state [/etc/salt/minion.d/_virt.conf] at time 08:32:49.778736 duration_in_ms=6.154
2017-12-01 08:32:49,780 [salt.state       ][INFO    ][22065] Running state [salt-minion] at time 08:32:49.780128
2017-12-01 08:32:49,780 [salt.state       ][INFO    ][22065] Executing state service.running for salt-minion
2017-12-01 08:32:49,781 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-01 08:32:49,797 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-01 08:32:49,805 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-01 08:32:49,813 [salt.state       ][INFO    ][22065] The service salt-minion is already running
2017-12-01 08:32:49,813 [salt.state       ][INFO    ][22065] Completed state [salt-minion] at time 08:32:49.812707 duration_in_ms=32.579
2017-12-01 08:32:49,814 [salt.state       ][INFO    ][22065] Running state [/etc/salt/grains.d] at time 08:32:49.813917
2017-12-01 08:32:49,814 [salt.state       ][INFO    ][22065] Executing state file.directory for /etc/salt/grains.d
2017-12-01 08:32:49,815 [salt.state       ][INFO    ][22065] Directory /etc/salt/grains.d is in the correct state
2017-12-01 08:32:49,815 [salt.state       ][INFO    ][22065] Completed state [/etc/salt/grains.d] at time 08:32:49.814745 duration_in_ms=0.828
2017-12-01 08:32:49,815 [salt.state       ][INFO    ][22065] Running state [/etc/salt/grains] at time 08:32:49.815145
2017-12-01 08:32:49,815 [salt.state       ][INFO    ][22065] Executing state file.managed for /etc/salt/grains
2017-12-01 08:32:49,816 [salt.state       ][INFO    ][22065] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-01 08:32:49,816 [salt.state       ][INFO    ][22065] Completed state [/etc/salt/grains] at time 08:32:49.815748 duration_in_ms=0.603
2017-12-01 08:32:49,816 [salt.state       ][INFO    ][22065] Running state [/etc/salt/grains.d/placeholder] at time 08:32:49.816002
2017-12-01 08:32:49,816 [salt.state       ][INFO    ][22065] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-01 08:32:49,816 [salt.state       ][INFO    ][22065] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-01 08:32:49,817 [salt.state       ][INFO    ][22065] Completed state [/etc/salt/grains.d/placeholder] at time 08:32:49.816570 duration_in_ms=0.568
2017-12-01 08:32:49,817 [salt.state       ][INFO    ][22065] Running state [/etc/salt/grains.d/sphinx] at time 08:32:49.816825
2017-12-01 08:32:49,817 [salt.state       ][INFO    ][22065] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-01 08:32:49,826 [salt.state       ][INFO    ][22065] File /etc/salt/grains.d/sphinx is in the correct state
2017-12-01 08:32:49,826 [salt.state       ][INFO    ][22065] Completed state [/etc/salt/grains.d/sphinx] at time 08:32:49.826281 duration_in_ms=9.456
2017-12-01 08:32:49,827 [salt.state       ][INFO    ][22065] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:32:49.826811
2017-12-01 08:32:49,827 [salt.state       ][INFO    ][22065] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-01 08:32:49,827 [salt.state       ][INFO    ][22065] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-01 08:32:49,827 [salt.state       ][INFO    ][22065] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:32:49.827281 duration_in_ms=0.469
2017-12-01 08:32:49,828 [salt.state       ][INFO    ][22065] Running state [/etc/salt/grains.d/dns_records] at time 08:32:49.827540
2017-12-01 08:32:49,828 [salt.state       ][INFO    ][22065] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-01 08:32:49,832 [salt.state       ][INFO    ][22065] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-01 08:32:49,833 [salt.state       ][INFO    ][22065] Completed state [/etc/salt/grains.d/dns_records] at time 08:32:49.832568 duration_in_ms=5.029
2017-12-01 08:32:49,833 [salt.state       ][INFO    ][22065] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:32:49.833101
2017-12-01 08:32:49,833 [salt.state       ][INFO    ][22065] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-01 08:32:49,833 [salt.state       ][INFO    ][22065] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-01 08:32:49,834 [salt.state       ][INFO    ][22065] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:32:49.833572 duration_in_ms=0.47
2017-12-01 08:32:49,834 [salt.state       ][INFO    ][22065] Running state [/etc/salt/grains.d/salt] at time 08:32:49.833914
2017-12-01 08:32:49,834 [salt.state       ][INFO    ][22065] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-01 08:32:49,838 [salt.state       ][INFO    ][22065] File /etc/salt/grains.d/salt is in the correct state
2017-12-01 08:32:49,838 [salt.state       ][INFO    ][22065] Completed state [/etc/salt/grains.d/salt] at time 08:32:49.838282 duration_in_ms=4.369
2017-12-01 08:32:49,839 [salt.state       ][INFO    ][22065] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:32:49.838789
2017-12-01 08:32:49,839 [salt.state       ][INFO    ][22065] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-01 08:32:49,839 [salt.state       ][INFO    ][22065] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-01 08:32:49,839 [salt.state       ][INFO    ][22065] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:32:49.839255 duration_in_ms=0.465
2017-12-01 08:32:49,840 [salt.state       ][INFO    ][22065] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:32:49.840363
2017-12-01 08:32:49,841 [salt.state       ][INFO    ][22065] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-01 08:32:49,841 [salt.state       ][INFO    ][22065] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-01 08:32:49,841 [salt.state       ][INFO    ][22065] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:32:49.840834 duration_in_ms=0.471
2017-12-01 08:32:49,841 [salt.state       ][INFO    ][22065] Running state [mine.update] at time 08:32:49.841223
2017-12-01 08:32:49,841 [salt.state       ][INFO    ][22065] Executing state module.wait for mine.update
2017-12-01 08:32:49,842 [salt.state       ][INFO    ][22065] No changes made for mine.update
2017-12-01 08:32:49,842 [salt.state       ][INFO    ][22065] Completed state [mine.update] at time 08:32:49.841654 duration_in_ms=0.431
2017-12-01 08:32:49,842 [salt.state       ][INFO    ][22065] Running state [ca-certificates] at time 08:32:49.841806
2017-12-01 08:32:49,842 [salt.state       ][INFO    ][22065] Executing state pkg.installed for ca-certificates
2017-12-01 08:32:49,845 [salt.state       ][INFO    ][22065] Package ca-certificates is already installed
2017-12-01 08:32:49,845 [salt.state       ][INFO    ][22065] Completed state [ca-certificates] at time 08:32:49.844942 duration_in_ms=3.136
2017-12-01 08:32:49,845 [salt.state       ][INFO    ][22065] Running state [update-ca-certificates] at time 08:32:49.845345
2017-12-01 08:32:49,846 [salt.state       ][INFO    ][22065] Executing state cmd.wait for update-ca-certificates
2017-12-01 08:32:49,846 [salt.state       ][INFO    ][22065] No changes made for update-ca-certificates
2017-12-01 08:32:49,846 [salt.state       ][INFO    ][22065] Completed state [update-ca-certificates] at time 08:32:49.845808 duration_in_ms=0.463
2017-12-01 08:32:49,846 [salt.state       ][INFO    ][22065] Running state [libvirt-dev] at time 08:32:49.845952
2017-12-01 08:32:49,846 [salt.state       ][INFO    ][22065] Executing state pkg.installed for libvirt-dev
2017-12-01 08:32:49,849 [salt.state       ][INFO    ][22065] Package libvirt-dev is already installed
2017-12-01 08:32:49,849 [salt.state       ][INFO    ][22065] Completed state [libvirt-dev] at time 08:32:49.848721 duration_in_ms=2.769
2017-12-01 08:32:49,849 [salt.state       ][INFO    ][22065] Running state [pkg-config] at time 08:32:49.848860
2017-12-01 08:32:49,849 [salt.state       ][INFO    ][22065] Executing state pkg.installed for pkg-config
2017-12-01 08:32:49,852 [salt.state       ][INFO    ][22065] Package pkg-config is already installed
2017-12-01 08:32:49,852 [salt.state       ][INFO    ][22065] Completed state [pkg-config] at time 08:32:49.851695 duration_in_ms=2.835
2017-12-01 08:32:49,852 [salt.state       ][INFO    ][22065] Running state [virtng.init] at time 08:32:49.851836
2017-12-01 08:32:49,852 [salt.state       ][INFO    ][22065] Executing state module.run for virtng.init
2017-12-01 08:32:49,941 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command ['git', '--version'] in directory '/root'
2017-12-01 08:32:49,984 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:50,001 [salt.state       ][INFO    ][22065] unless execution succeeded
2017-12-01 08:32:50,002 [salt.state       ][INFO    ][22065] Completed state [virtng.init] at time 08:32:50.001576 duration_in_ms=149.739
2017-12-01 08:32:50,002 [salt.state       ][INFO    ][22065] Running state [virt.set_autostart] at time 08:32:50.001868
2017-12-01 08:32:50,002 [salt.state       ][INFO    ][22065] Executing state module.run for virt.set_autostart
2017-12-01 08:32:50,004 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:50,019 [salt.state       ][INFO    ][22065] unless execution succeeded
2017-12-01 08:32:50,019 [salt.state       ][INFO    ][22065] Completed state [virt.set_autostart] at time 08:32:50.019307 duration_in_ms=17.438
2017-12-01 08:32:50,020 [salt.state       ][INFO    ][22065] Running state [virtng.init] at time 08:32:50.019520
2017-12-01 08:32:50,020 [salt.state       ][INFO    ][22065] Executing state module.run for virtng.init
2017-12-01 08:32:50,022 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:50,036 [salt.state       ][INFO    ][22065] unless execution succeeded
2017-12-01 08:32:50,036 [salt.state       ][INFO    ][22065] Completed state [virtng.init] at time 08:32:50.036158 duration_in_ms=16.637
2017-12-01 08:32:50,036 [salt.state       ][INFO    ][22065] Running state [virt.set_autostart] at time 08:32:50.036384
2017-12-01 08:32:50,037 [salt.state       ][INFO    ][22065] Executing state module.run for virt.set_autostart
2017-12-01 08:32:50,039 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:50,053 [salt.state       ][INFO    ][22065] unless execution succeeded
2017-12-01 08:32:50,054 [salt.state       ][INFO    ][22065] Completed state [virt.set_autostart] at time 08:32:50.053610 duration_in_ms=17.226
2017-12-01 08:32:50,054 [salt.state       ][INFO    ][22065] Running state [virtng.init] at time 08:32:50.053837
2017-12-01 08:32:50,054 [salt.state       ][INFO    ][22065] Executing state module.run for virtng.init
2017-12-01 08:32:50,056 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:50,070 [salt.state       ][INFO    ][22065] unless execution succeeded
2017-12-01 08:32:50,070 [salt.state       ][INFO    ][22065] Completed state [virtng.init] at time 08:32:50.069747 duration_in_ms=15.909
2017-12-01 08:32:50,070 [salt.state       ][INFO    ][22065] Running state [virt.set_autostart] at time 08:32:50.069998
2017-12-01 08:32:50,070 [salt.state       ][INFO    ][22065] Executing state module.run for virt.set_autostart
2017-12-01 08:32:50,072 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:50,086 [salt.state       ][INFO    ][22065] unless execution succeeded
2017-12-01 08:32:50,086 [salt.state       ][INFO    ][22065] Completed state [virt.set_autostart] at time 08:32:50.086117 duration_in_ms=16.119
2017-12-01 08:32:50,086 [salt.state       ][INFO    ][22065] Running state [virtng.init] at time 08:32:50.086322
2017-12-01 08:32:50,086 [salt.state       ][INFO    ][22065] Executing state module.run for virtng.init
2017-12-01 08:32:50,088 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:50,102 [salt.state       ][INFO    ][22065] unless execution succeeded
2017-12-01 08:32:50,102 [salt.state       ][INFO    ][22065] Completed state [virtng.init] at time 08:32:50.101893 duration_in_ms=15.571
2017-12-01 08:32:50,102 [salt.state       ][INFO    ][22065] Running state [virt.set_autostart] at time 08:32:50.102139
2017-12-01 08:32:50,102 [salt.state       ][INFO    ][22065] Executing state module.run for virt.set_autostart
2017-12-01 08:32:50,104 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:50,118 [salt.state       ][INFO    ][22065] unless execution succeeded
2017-12-01 08:32:50,118 [salt.state       ][INFO    ][22065] Completed state [virt.set_autostart] at time 08:32:50.118258 duration_in_ms=16.119
2017-12-01 08:32:50,118 [salt.state       ][INFO    ][22065] Running state [virtng.init] at time 08:32:50.118453
2017-12-01 08:32:50,119 [salt.state       ][INFO    ][22065] Executing state module.run for virtng.init
2017-12-01 08:32:50,120 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:50,134 [salt.state       ][INFO    ][22065] unless execution succeeded
2017-12-01 08:32:50,134 [salt.state       ][INFO    ][22065] Completed state [virtng.init] at time 08:32:50.133920 duration_in_ms=15.467
2017-12-01 08:32:50,134 [salt.state       ][INFO    ][22065] Running state [virt.set_autostart] at time 08:32:50.134149
2017-12-01 08:32:50,134 [salt.state       ][INFO    ][22065] Executing state module.run for virt.set_autostart
2017-12-01 08:32:50,136 [salt.loaded.int.module.cmdmod][INFO    ][22065] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-01 08:32:50,151 [salt.state       ][INFO    ][22065] unless execution succeeded
2017-12-01 08:32:50,151 [salt.state       ][INFO    ][22065] Completed state [virt.set_autostart] at time 08:32:50.150803 duration_in_ms=16.653
2017-12-01 08:32:50,153 [salt.minion      ][INFO    ][22065] Returning information for job: 20171201083245585762
2017-12-01 08:32:53,483 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command pillar.get with jid 20171201083253470465
2017-12-01 08:32:53,496 [salt.minion      ][INFO    ][22160] Starting a new job with PID 22160
2017-12-01 08:32:53,500 [salt.minion      ][INFO    ][22160] Returning information for job: 20171201083253470465
2017-12-01 08:33:36,586 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171201083336570488
2017-12-01 08:33:36,599 [salt.minion      ][INFO    ][22185] Starting a new job with PID 22185
2017-12-01 08:33:39,475 [salt.state       ][INFO    ][22185] Loading fresh modules for state activity
2017-12-01 08:33:40,024 [salt.state       ][ERROR   ][22185] No contents found in top file
2017-12-01 08:33:40,025 [salt.utils.extmods][INFO    ][22185] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-01 08:33:40,027 [salt.utils.extmods][INFO    ][22185] Syncing beacons for environment 'base'
2017-12-01 08:33:40,028 [salt.utils.extmods][INFO    ][22185] Loading cache from salt://_beacons, for base)
2017-12-01 08:33:40,028 [salt.fileclient  ][INFO    ][22185] Caching directory '_beacons/' for environment 'base'
2017-12-01 08:33:40,054 [salt.utils.extmods][INFO    ][22185] Syncing modules for environment 'base'
2017-12-01 08:33:40,054 [salt.utils.extmods][INFO    ][22185] Loading cache from salt://_modules, for base)
2017-12-01 08:33:40,055 [salt.fileclient  ][INFO    ][22185] Caching directory '_modules/' for environment 'base'
2017-12-01 08:33:40,389 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-01 08:33:40,440 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-01 08:33:40,469 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-01 08:33:40,492 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-01 08:33:40,520 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-01 08:33:40,546 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-01 08:33:40,597 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-01 08:33:40,621 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-01 08:33:40,644 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-01 08:33:40,657 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-01 08:33:40,688 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-01 08:33:40,704 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-01 08:33:40,744 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-01 08:33:40,772 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-01 08:33:40,791 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-01 08:33:40,808 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-01 08:33:40,822 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-01 08:33:40,853 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-01 08:33:40,861 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-01 08:33:40,890 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-01 08:33:40,901 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-01 08:33:40,919 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-01 08:33:40,932 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-01 08:33:41,004 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-01 08:33:41,014 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-01 08:33:41,030 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-01 08:33:41,096 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-01 08:33:41,105 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-01 08:33:41,119 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-01 08:33:41,187 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-01 08:33:41,195 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-01 08:33:41,208 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-01 08:33:41,218 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-01 08:33:41,228 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-01 08:33:41,232 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-01 08:33:41,233 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-01 08:33:41,233 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-01 08:33:41,233 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-01 08:33:41,233 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-01 08:33:41,234 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-01 08:33:41,234 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-01 08:33:41,234 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-01 08:33:41,234 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-01 08:33:41,234 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-01 08:33:41,235 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-01 08:33:41,235 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-01 08:33:41,235 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-01 08:33:41,235 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-01 08:33:41,236 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-01 08:33:41,236 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-01 08:33:41,236 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-01 08:33:41,237 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-01 08:33:41,237 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-01 08:33:41,237 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-01 08:33:41,237 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-01 08:33:41,238 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-01 08:33:41,238 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-01 08:33:41,238 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-01 08:33:41,238 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-01 08:33:41,239 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-01 08:33:41,239 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-01 08:33:41,239 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-01 08:33:41,239 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-01 08:33:41,240 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-01 08:33:41,240 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-01 08:33:41,240 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-01 08:33:41,241 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-01 08:33:41,241 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-12-01 08:33:41,241 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-01 08:33:41,241 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-01 08:33:41,247 [salt.utils.extmods][INFO    ][22185] Syncing states for environment 'base'
2017-12-01 08:33:41,247 [salt.utils.extmods][INFO    ][22185] Loading cache from salt://_states, for base)
2017-12-01 08:33:41,247 [salt.fileclient  ][INFO    ][22185] Caching directory '_states/' for environment 'base'
2017-12-01 08:33:41,300 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-01 08:33:41,339 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-01 08:33:41,356 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-01 08:33:41,371 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-01 08:33:41,383 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-01 08:33:41,397 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-01 08:33:41,411 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-01 08:33:41,428 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-01 08:33:41,439 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-01 08:33:41,468 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-01 08:33:41,503 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-01 08:33:41,514 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-01 08:33:41,533 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-01 08:33:41,589 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-01 08:33:41,612 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-01 08:33:41,690 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-01 08:33:41,709 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-01 08:33:41,774 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-01 08:33:41,782 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-01 08:33:41,790 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-01 08:33:41,800 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-01 08:33:41,814 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-01 08:33:41,822 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-01 08:33:41,842 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-01 08:33:41,918 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-01 08:33:41,929 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-01 08:33:41,948 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-01 08:33:41,967 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-01 08:33:42,001 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-01 08:33:42,011 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-01 08:33:42,030 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-01 08:33:42,047 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-01 08:33:42,050 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-01 08:33:42,050 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-01 08:33:42,051 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-01 08:33:42,051 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-01 08:33:42,051 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-01 08:33:42,051 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-01 08:33:42,052 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-01 08:33:42,052 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-01 08:33:42,052 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-01 08:33:42,053 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-01 08:33:42,053 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-01 08:33:42,053 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-01 08:33:42,053 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-01 08:33:42,054 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-01 08:33:42,054 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-01 08:33:42,054 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-01 08:33:42,054 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-01 08:33:42,054 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-01 08:33:42,055 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-01 08:33:42,055 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-01 08:33:42,055 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-01 08:33:42,055 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-01 08:33:42,055 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-01 08:33:42,056 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-01 08:33:42,056 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-01 08:33:42,056 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-01 08:33:42,056 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-01 08:33:42,056 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-01 08:33:42,057 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-01 08:33:42,057 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-01 08:33:42,057 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-01 08:33:42,058 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-01 08:33:42,058 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-01 08:33:42,061 [salt.utils.extmods][INFO    ][22185] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-01 08:33:42,063 [salt.utils.extmods][INFO    ][22185] Syncing sdb for environment 'base'
2017-12-01 08:33:42,063 [salt.utils.extmods][INFO    ][22185] Loading cache from salt://_sdb, for base)
2017-12-01 08:33:42,063 [salt.fileclient  ][INFO    ][22185] Caching directory '_sdb/' for environment 'base'
2017-12-01 08:33:42,094 [salt.utils.extmods][INFO    ][22185] Syncing grains for environment 'base'
2017-12-01 08:33:42,094 [salt.utils.extmods][INFO    ][22185] Loading cache from salt://_grains, for base)
2017-12-01 08:33:42,094 [salt.fileclient  ][INFO    ][22185] Caching directory '_grains/' for environment 'base'
2017-12-01 08:33:42,170 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-01 08:33:42,191 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-01 08:33:42,231 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-01 08:33:42,258 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-01 08:33:42,266 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-01 08:33:42,290 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-01 08:33:42,302 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-01 08:33:42,313 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-01 08:33:42,330 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-01 08:33:42,362 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-01 08:33:42,371 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-01 08:33:42,389 [salt.fileclient  ][INFO    ][22185] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-01 08:33:42,392 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-01 08:33:42,393 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-01 08:33:42,393 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-01 08:33:42,393 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-01 08:33:42,393 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-01 08:33:42,393 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-01 08:33:42,394 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-01 08:33:42,394 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-01 08:33:42,394 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-01 08:33:42,394 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-01 08:33:42,394 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-01 08:33:42,394 [salt.utils.extmods][INFO    ][22185] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-01 08:33:42,396 [salt.utils.extmods][INFO    ][22185] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-01 08:33:42,398 [salt.utils.extmods][INFO    ][22185] Syncing renderers for environment 'base'
2017-12-01 08:33:42,398 [salt.utils.extmods][INFO    ][22185] Loading cache from salt://_renderers, for base)
2017-12-01 08:33:42,398 [salt.fileclient  ][INFO    ][22185] Caching directory '_renderers/' for environment 'base'
2017-12-01 08:33:42,421 [salt.utils.extmods][INFO    ][22185] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-01 08:33:42,423 [salt.utils.extmods][INFO    ][22185] Syncing returners for environment 'base'
2017-12-01 08:33:42,423 [salt.utils.extmods][INFO    ][22185] Loading cache from salt://_returners, for base)
2017-12-01 08:33:42,423 [salt.fileclient  ][INFO    ][22185] Caching directory '_returners/' for environment 'base'
2017-12-01 08:33:42,464 [salt.utils.extmods][INFO    ][22185] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-01 08:33:42,466 [salt.utils.extmods][INFO    ][22185] Syncing output for environment 'base'
2017-12-01 08:33:42,466 [salt.utils.extmods][INFO    ][22185] Loading cache from salt://_output, for base)
2017-12-01 08:33:42,466 [salt.fileclient  ][INFO    ][22185] Caching directory '_output/' for environment 'base'
2017-12-01 08:33:42,486 [salt.utils.extmods][INFO    ][22185] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-01 08:33:42,507 [salt.utils.extmods][INFO    ][22185] Syncing utils for environment 'base'
2017-12-01 08:33:42,507 [salt.utils.extmods][INFO    ][22185] Loading cache from salt://_utils, for base)
2017-12-01 08:33:42,508 [salt.fileclient  ][INFO    ][22185] Caching directory '_utils/' for environment 'base'
2017-12-01 08:33:42,526 [salt.utils.extmods][INFO    ][22185] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-01 08:33:42,529 [salt.utils.extmods][INFO    ][22185] Syncing log_handlers for environment 'base'
2017-12-01 08:33:42,529 [salt.utils.extmods][INFO    ][22185] Loading cache from salt://_log_handlers, for base)
2017-12-01 08:33:42,529 [salt.fileclient  ][INFO    ][22185] Caching directory '_log_handlers/' for environment 'base'
2017-12-01 08:33:42,572 [salt.utils.extmods][INFO    ][22185] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-01 08:33:42,574 [salt.utils.extmods][INFO    ][22185] Syncing proxy for environment 'base'
2017-12-01 08:33:42,574 [salt.utils.extmods][INFO    ][22185] Loading cache from salt://_proxy, for base)
2017-12-01 08:33:42,574 [salt.fileclient  ][INFO    ][22185] Caching directory '_proxy/' for environment 'base'
2017-12-01 08:33:42,595 [salt.utils.extmods][INFO    ][22185] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-01 08:33:42,597 [salt.utils.extmods][INFO    ][22185] Syncing engines for environment 'base'
2017-12-01 08:33:42,598 [salt.utils.extmods][INFO    ][22185] Loading cache from salt://_engines, for base)
2017-12-01 08:33:42,598 [salt.fileclient  ][INFO    ][22185] Caching directory '_engines/' for environment 'base'
2017-12-01 08:33:42,625 [salt.minion      ][INFO    ][22185] Returning information for job: 20171201083336570488
2017-12-01 08:42:54,671 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command test.ping with jid 20171201084254661803
2017-12-01 08:42:54,688 [salt.minion      ][INFO    ][22399] Starting a new job with PID 22399
2017-12-01 08:42:54,740 [salt.minion      ][INFO    ][22399] Returning information for job: 20171201084254661803
2017-12-01 08:46:24,878 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command state.sls with jid 20171201084624863708
2017-12-01 08:46:24,893 [salt.minion      ][INFO    ][22449] Starting a new job with PID 22449
2017-12-01 08:46:25,408 [salt.state       ][INFO    ][22449] Loading fresh modules for state activity
2017-12-01 08:46:25,431 [salt.fileclient  ][INFO    ][22449] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-01 08:46:25,448 [salt.fileclient  ][INFO    ][22449] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-01 08:46:25,471 [salt.fileclient  ][INFO    ][22449] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-01 08:46:25,787 [salt.state       ][INFO    ][22449] Running state [lsof] at time 08:46:25.786789
2017-12-01 08:46:25,787 [salt.state       ][INFO    ][22449] Executing state pkg.installed for lsof
2017-12-01 08:46:25,787 [salt.loaded.int.module.cmdmod][INFO    ][22449] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:46:26,078 [salt.state       ][INFO    ][22449] Package lsof is already installed
2017-12-01 08:46:26,078 [salt.state       ][INFO    ][22449] Completed state [lsof] at time 08:46:26.078073 duration_in_ms=291.284
2017-12-01 08:46:26,078 [salt.state       ][INFO    ][22449] Running state [keepalived] at time 08:46:26.078297
2017-12-01 08:46:26,078 [salt.state       ][INFO    ][22449] Executing state pkg.installed for keepalived
2017-12-01 08:46:26,093 [salt.loaded.int.module.cmdmod][INFO    ][22449] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 08:46:27,594 [salt.loaded.int.module.cmdmod][INFO    ][22449] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-12-01 08:46:34,924 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201084634909373
2017-12-01 08:46:34,938 [salt.minion      ][INFO    ][23730] Starting a new job with PID 23730
2017-12-01 08:46:34,948 [salt.minion      ][INFO    ][23730] Returning information for job: 20171201084634909373
2017-12-01 08:46:36,198 [salt.loaded.int.module.cmdmod][INFO    ][22449] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:46:36,223 [salt.state       ][INFO    ][22449] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-12-01 08:46:36,232 [salt.state       ][INFO    ][22449] Loading fresh modules for state activity
2017-12-01 08:46:36,244 [salt.state       ][INFO    ][22449] Completed state [keepalived] at time 08:46:36.244190 duration_in_ms=10165.892
2017-12-01 08:46:36,247 [salt.state       ][INFO    ][22449] Running state [/etc/keepalived/keepalived.conf] at time 08:46:36.247156
2017-12-01 08:46:36,247 [salt.state       ][INFO    ][22449] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-01 08:46:36,272 [salt.fileclient  ][INFO    ][22449] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-01 08:46:36,306 [salt.fileclient  ][INFO    ][22449] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-01 08:46:36,313 [salt.state       ][INFO    ][22449] File changed:
New file
2017-12-01 08:46:36,313 [salt.state       ][INFO    ][22449] Completed state [/etc/keepalived/keepalived.conf] at time 08:46:36.313209 duration_in_ms=66.052
2017-12-01 08:46:36,372 [salt.state       ][INFO    ][22449] Running state [keepalived] at time 08:46:36.372369
2017-12-01 08:46:36,373 [salt.state       ][INFO    ][22449] Executing state service.running for keepalived
2017-12-01 08:46:36,374 [salt.loaded.int.module.cmdmod][INFO    ][22449] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-01 08:46:36,382 [salt.loaded.int.module.cmdmod][INFO    ][22449] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-01 08:46:36,387 [salt.loaded.int.module.cmdmod][INFO    ][22449] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-01 08:46:36,393 [salt.loaded.int.module.cmdmod][INFO    ][22449] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-01 08:46:36,400 [salt.loaded.int.module.cmdmod][INFO    ][22449] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-12-01 08:46:36,454 [salt.loaded.int.module.cmdmod][INFO    ][22449] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-01 08:46:36,461 [salt.loaded.int.module.cmdmod][INFO    ][22449] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-01 08:46:36,466 [salt.loaded.int.module.cmdmod][INFO    ][22449] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-01 08:46:36,472 [salt.state       ][INFO    ][22449] {'keepalived': True}
2017-12-01 08:46:36,472 [salt.state       ][INFO    ][22449] Completed state [keepalived] at time 08:46:36.472176 duration_in_ms=99.807
2017-12-01 08:46:36,473 [salt.minion      ][INFO    ][22449] Returning information for job: 20171201084624863708
2017-12-01 08:46:53,116 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command pillar.get with jid 20171201084653101822
2017-12-01 08:46:53,132 [salt.minion      ][INFO    ][23930] Starting a new job with PID 23930
2017-12-01 08:46:53,141 [salt.minion      ][INFO    ][23930] Returning information for job: 20171201084653101822
2017-12-01 08:52:15,422 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command state.sls with jid 20171201085215411576
2017-12-01 08:52:15,433 [salt.minion      ][INFO    ][24023] Starting a new job with PID 24023
2017-12-01 08:52:16,936 [salt.state       ][INFO    ][24023] Loading fresh modules for state activity
2017-12-01 08:52:16,962 [salt.fileclient  ][INFO    ][24023] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-01 08:52:16,985 [salt.fileclient  ][INFO    ][24023] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-01 08:52:17,258 [salt.state       ][INFO    ][24023] Running state [attr] at time 08:52:17.258430
2017-12-01 08:52:17,259 [salt.state       ][INFO    ][24023] Executing state pkg.installed for attr
2017-12-01 08:52:17,259 [salt.loaded.int.module.cmdmod][INFO    ][24023] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:52:17,542 [salt.loaded.int.module.cmdmod][INFO    ][24023] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 08:52:19,042 [salt.loaded.int.module.cmdmod][INFO    ][24023] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-12-01 08:52:21,543 [salt.loaded.int.module.cmdmod][INFO    ][24023] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:52:21,564 [salt.state       ][INFO    ][24023] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-12-01 08:52:21,572 [salt.state       ][INFO    ][24023] Loading fresh modules for state activity
2017-12-01 08:52:21,584 [salt.state       ][INFO    ][24023] Completed state [attr] at time 08:52:21.584009 duration_in_ms=4325.579
2017-12-01 08:52:21,588 [salt.state       ][INFO    ][24023] Running state [glusterfs-server] at time 08:52:21.588221
2017-12-01 08:52:21,588 [salt.state       ][INFO    ][24023] Executing state pkg.installed for glusterfs-server
2017-12-01 08:52:21,766 [salt.loaded.int.module.cmdmod][INFO    ][24023] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-12-01 08:52:25,514 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201085225499800
2017-12-01 08:52:25,526 [salt.minion      ][INFO    ][24921] Starting a new job with PID 24921
2017-12-01 08:52:25,539 [salt.minion      ][INFO    ][24921] Returning information for job: 20171201085225499800
2017-12-01 08:52:35,710 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201085235695639
2017-12-01 08:52:35,722 [salt.minion      ][INFO    ][26030] Starting a new job with PID 26030
2017-12-01 08:52:35,741 [salt.minion      ][INFO    ][26030] Returning information for job: 20171201085235695639
2017-12-01 08:52:39,732 [salt.loaded.int.module.cmdmod][INFO    ][24023] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:52:39,756 [salt.state       ][INFO    ][24023] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'glusterfs-client' changed from 'absent' to '3.10.8-ubuntu1~xenial1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.2'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'glusterfs-common' changed from 'absent' to '3.10.8-ubuntu1~xenial1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'portmap' changed from 'absent' to '1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'
'nfs-client' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.10.8-ubuntu1~xenial1'

2017-12-01 08:52:39,763 [salt.state       ][INFO    ][24023] Loading fresh modules for state activity
2017-12-01 08:52:39,775 [salt.state       ][INFO    ][24023] Completed state [glusterfs-server] at time 08:52:39.775458 duration_in_ms=18187.236
2017-12-01 08:52:39,779 [salt.state       ][INFO    ][24023] Running state [bc] at time 08:52:39.779394
2017-12-01 08:52:39,780 [salt.state       ][INFO    ][24023] Executing state pkg.installed for bc
2017-12-01 08:52:40,029 [salt.loaded.int.module.cmdmod][INFO    ][24023] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-12-01 08:52:42,934 [salt.loaded.int.module.cmdmod][INFO    ][24023] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:52:42,957 [salt.state       ][INFO    ][24023] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-12-01 08:52:42,965 [salt.state       ][INFO    ][24023] Loading fresh modules for state activity
2017-12-01 08:52:42,978 [salt.state       ][INFO    ][24023] Completed state [bc] at time 08:52:42.978054 duration_in_ms=3198.659
2017-12-01 08:52:43,037 [salt.state       ][INFO    ][24023] Running state [glusterfs-server] at time 08:52:43.037457
2017-12-01 08:52:43,038 [salt.state       ][INFO    ][24023] Executing state service.running for glusterfs-server
2017-12-01 08:52:43,039 [salt.loaded.int.module.cmdmod][INFO    ][24023] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-01 08:52:43,047 [salt.loaded.int.module.cmdmod][INFO    ][24023] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-01 08:52:43,053 [salt.loaded.int.module.cmdmod][INFO    ][24023] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-01 08:52:43,061 [salt.state       ][INFO    ][24023] The service glusterfs-server is already running
2017-12-01 08:52:43,061 [salt.state       ][INFO    ][24023] Completed state [glusterfs-server] at time 08:52:43.061193 duration_in_ms=23.736
2017-12-01 08:52:43,063 [salt.state       ][INFO    ][24023] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:52:43.062652
2017-12-01 08:52:43,063 [salt.state       ][INFO    ][24023] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-01 08:52:43,077 [salt.state       ][INFO    ][24023] File changed:
New file
2017-12-01 08:52:43,077 [salt.state       ][INFO    ][24023] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:52:43.076789 duration_in_ms=14.136
2017-12-01 08:52:43,077 [salt.state       ][INFO    ][24023] Running state [/srv/glusterfs/glance] at time 08:52:43.076943
2017-12-01 08:52:43,077 [salt.state       ][INFO    ][24023] Executing state file.directory for /srv/glusterfs/glance
2017-12-01 08:52:43,078 [salt.state       ][INFO    ][24023] {'/srv/glusterfs/glance': 'New Dir'}
2017-12-01 08:52:43,078 [salt.state       ][INFO    ][24023] Completed state [/srv/glusterfs/glance] at time 08:52:43.077827 duration_in_ms=0.884
2017-12-01 08:52:43,078 [salt.state       ][INFO    ][24023] Running state [/srv/glusterfs/keystone-keys] at time 08:52:43.077977
2017-12-01 08:52:43,078 [salt.state       ][INFO    ][24023] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-01 08:52:43,078 [salt.state       ][INFO    ][24023] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-12-01 08:52:43,079 [salt.state       ][INFO    ][24023] Completed state [/srv/glusterfs/keystone-keys] at time 08:52:43.078599 duration_in_ms=0.623
2017-12-01 08:52:43,079 [salt.state       ][INFO    ][24023] Running state [/srv/glusterfs/nova_instances] at time 08:52:43.078742
2017-12-01 08:52:43,079 [salt.state       ][INFO    ][24023] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-01 08:52:43,079 [salt.state       ][INFO    ][24023] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-12-01 08:52:43,079 [salt.state       ][INFO    ][24023] Completed state [/srv/glusterfs/nova_instances] at time 08:52:43.079358 duration_in_ms=0.616
2017-12-01 08:52:43,080 [salt.state       ][INFO    ][24023] Running state [/srv/glusterfs/keystone-credential-keys] at time 08:52:43.079502
2017-12-01 08:52:43,080 [salt.state       ][INFO    ][24023] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-01 08:52:43,080 [salt.state       ][INFO    ][24023] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-12-01 08:52:43,080 [salt.state       ][INFO    ][24023] Completed state [/srv/glusterfs/keystone-credential-keys] at time 08:52:43.080122 duration_in_ms=0.62
2017-12-01 08:52:43,081 [salt.minion      ][INFO    ][24023] Returning information for job: 20171201085215411576
2017-12-01 08:52:45,177 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command test.ping with jid 20171201085245169245
2017-12-01 08:52:45,189 [salt.minion      ][INFO    ][26893] Starting a new job with PID 26893
2017-12-01 08:52:45,215 [salt.minion      ][INFO    ][26893] Returning information for job: 20171201085245169245
2017-12-01 08:53:28,587 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command state.sls with jid 20171201085328573588
2017-12-01 08:53:28,601 [salt.minion      ][INFO    ][27529] Starting a new job with PID 27529
2017-12-01 08:53:29,072 [salt.state       ][INFO    ][27529] Loading fresh modules for state activity
2017-12-01 08:53:29,092 [salt.fileclient  ][INFO    ][27529] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-01 08:53:29,125 [salt.fileclient  ][INFO    ][27529] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-01 08:53:29,195 [salt.fileclient  ][INFO    ][27529] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-01 08:53:29,212 [salt.fileclient  ][INFO    ][27529] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-01 08:53:29,473 [salt.state       ][INFO    ][27529] Running state [attr] at time 08:53:29.472724
2017-12-01 08:53:29,473 [salt.state       ][INFO    ][27529] Executing state pkg.installed for attr
2017-12-01 08:53:29,473 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:53:29,740 [salt.state       ][INFO    ][27529] Package attr is already installed
2017-12-01 08:53:29,740 [salt.state       ][INFO    ][27529] Completed state [attr] at time 08:53:29.740395 duration_in_ms=267.671
2017-12-01 08:53:29,741 [salt.state       ][INFO    ][27529] Running state [glusterfs-server] at time 08:53:29.740593
2017-12-01 08:53:29,741 [salt.state       ][INFO    ][27529] Executing state pkg.installed for glusterfs-server
2017-12-01 08:53:29,743 [salt.state       ][INFO    ][27529] Package glusterfs-server is already installed
2017-12-01 08:53:29,744 [salt.state       ][INFO    ][27529] Completed state [glusterfs-server] at time 08:53:29.743493 duration_in_ms=2.9
2017-12-01 08:53:29,744 [salt.state       ][INFO    ][27529] Running state [bc] at time 08:53:29.743651
2017-12-01 08:53:29,744 [salt.state       ][INFO    ][27529] Executing state pkg.installed for bc
2017-12-01 08:53:29,746 [salt.state       ][INFO    ][27529] Package bc is already installed
2017-12-01 08:53:29,746 [salt.state       ][INFO    ][27529] Completed state [bc] at time 08:53:29.746449 duration_in_ms=2.798
2017-12-01 08:53:29,747 [salt.state       ][INFO    ][27529] Running state [glusterfs-server] at time 08:53:29.747247
2017-12-01 08:53:29,747 [salt.state       ][INFO    ][27529] Executing state service.running for glusterfs-server
2017-12-01 08:53:29,748 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-01 08:53:29,757 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-01 08:53:29,801 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-01 08:53:29,814 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-01 08:53:29,819 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-01 08:53:29,826 [salt.state       ][INFO    ][27529] The service glusterfs-server is already running
2017-12-01 08:53:29,826 [salt.state       ][INFO    ][27529] Completed state [glusterfs-server] at time 08:53:29.826165 duration_in_ms=78.916
2017-12-01 08:53:29,828 [salt.state       ][INFO    ][27529] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:53:29.827478
2017-12-01 08:53:29,828 [salt.state       ][INFO    ][27529] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-01 08:53:29,838 [salt.state       ][INFO    ][27529] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-01 08:53:29,838 [salt.state       ][INFO    ][27529] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:53:29.838349 duration_in_ms=10.87
2017-12-01 08:53:29,839 [salt.state       ][INFO    ][27529] Running state [/srv/glusterfs/glance] at time 08:53:29.838525
2017-12-01 08:53:29,839 [salt.state       ][INFO    ][27529] Executing state file.directory for /srv/glusterfs/glance
2017-12-01 08:53:29,839 [salt.state       ][INFO    ][27529] Directory /srv/glusterfs/glance is in the correct state
2017-12-01 08:53:29,839 [salt.state       ][INFO    ][27529] Completed state [/srv/glusterfs/glance] at time 08:53:29.839144 duration_in_ms=0.619
2017-12-01 08:53:29,839 [salt.state       ][INFO    ][27529] Running state [/srv/glusterfs/keystone-keys] at time 08:53:29.839287
2017-12-01 08:53:29,839 [salt.state       ][INFO    ][27529] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-01 08:53:29,840 [salt.state       ][INFO    ][27529] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-01 08:53:29,840 [salt.state       ][INFO    ][27529] Completed state [/srv/glusterfs/keystone-keys] at time 08:53:29.839841 duration_in_ms=0.554
2017-12-01 08:53:29,840 [salt.state       ][INFO    ][27529] Running state [/srv/glusterfs/nova_instances] at time 08:53:29.839983
2017-12-01 08:53:29,840 [salt.state       ][INFO    ][27529] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-01 08:53:29,840 [salt.state       ][INFO    ][27529] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-01 08:53:29,841 [salt.state       ][INFO    ][27529] Completed state [/srv/glusterfs/nova_instances] at time 08:53:29.840558 duration_in_ms=0.575
2017-12-01 08:53:29,841 [salt.state       ][INFO    ][27529] Running state [/srv/glusterfs/keystone-credential-keys] at time 08:53:29.840701
2017-12-01 08:53:29,841 [salt.state       ][INFO    ][27529] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-01 08:53:29,841 [salt.state       ][INFO    ][27529] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-01 08:53:29,841 [salt.state       ][INFO    ][27529] Completed state [/srv/glusterfs/keystone-credential-keys] at time 08:53:29.841286 duration_in_ms=0.586
2017-12-01 08:53:29,892 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command ['git', '--version'] in directory '/root'
2017-12-01 08:53:29,980 [salt.state       ][INFO    ][27529] Running state [sleep 5] at time 08:53:29.980012
2017-12-01 08:53:29,980 [salt.state       ][INFO    ][27529] Executing state cmd.wait for sleep 5
2017-12-01 08:53:29,980 [salt.state       ][INFO    ][27529] No changes made for sleep 5
2017-12-01 08:53:29,981 [salt.state       ][INFO    ][27529] Completed state [sleep 5] at time 08:53:29.980563 duration_in_ms=0.553
2017-12-01 08:53:29,981 [salt.state       ][INFO    ][27529] Running state [10.167.4.141] at time 08:53:29.980968
2017-12-01 08:53:29,981 [salt.state       ][INFO    ][27529] Executing state glusterfs.peered for 10.167.4.141
2017-12-01 08:53:29,981 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:29,991 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:30,041 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:30,049 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:30,104 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:30,113 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:30,167 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:30,174 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:30,226 [salt.state       ][INFO    ][27529] Peering with localhost is not needed
2017-12-01 08:53:30,226 [salt.state       ][INFO    ][27529] Completed state [10.167.4.141] at time 08:53:30.225784 duration_in_ms=244.814
2017-12-01 08:53:30,228 [salt.state       ][INFO    ][27529] Running state [10.167.4.142] at time 08:53:30.227950
2017-12-01 08:53:30,228 [salt.state       ][INFO    ][27529] Executing state glusterfs.peered for 10.167.4.142
2017-12-01 08:53:30,229 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:30,236 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:30,287 [salt.state       ][INFO    ][27529] Host 10.167.4.142 already peered
2017-12-01 08:53:30,287 [salt.state       ][INFO    ][27529] Completed state [10.167.4.142] at time 08:53:30.286792 duration_in_ms=58.842
2017-12-01 08:53:30,289 [salt.state       ][INFO    ][27529] Running state [10.167.4.143] at time 08:53:30.289052
2017-12-01 08:53:30,289 [salt.state       ][INFO    ][27529] Executing state glusterfs.peered for 10.167.4.143
2017-12-01 08:53:30,290 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:30,298 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:30,347 [salt.state       ][INFO    ][27529] Host 10.167.4.143 already peered
2017-12-01 08:53:30,348 [salt.state       ][INFO    ][27529] Completed state [10.167.4.143] at time 08:53:30.347576 duration_in_ms=58.524
2017-12-01 08:53:30,348 [salt.state       ][INFO    ][27529] Running state [glance] at time 08:53:30.348369
2017-12-01 08:53:30,349 [salt.state       ][INFO    ][27529] Executing state glusterfs.created for glance
2017-12-01 08:53:30,349 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:30,357 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:30,406 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:30,414 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:30,469 [salt.state       ][INFO    ][27529] Volume glance already exists and is started.
2017-12-01 08:53:30,470 [salt.state       ][INFO    ][27529] Completed state [glance] at time 08:53:30.469578 duration_in_ms=121.209
2017-12-01 08:53:30,473 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:30.472777
2017-12-01 08:53:30,473 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-01 08:53:30,474 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-01 08:53:30,529 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:30,529 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:30.529368 duration_in_ms=56.591
2017-12-01 08:53:30,530 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 08:53:30.529847
2017-12-01 08:53:30,530 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-01 08:53:30,531 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-01 08:53:30,582 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:30,583 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 08:53:30.582505 duration_in_ms=52.658
2017-12-01 08:53:30,583 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 08:53:30.582975
2017-12-01 08:53:30,583 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-01 08:53:30,584 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-01 08:53:30,633 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:30,633 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 08:53:30.633351 duration_in_ms=50.376
2017-12-01 08:53:30,634 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 08:53:30.633790
2017-12-01 08:53:30,634 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-01 08:53:30,634 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-01 08:53:30,685 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:30,685 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 08:53:30.684930 duration_in_ms=51.14
2017-12-01 08:53:30,685 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:30.685373
2017-12-01 08:53:30,686 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-01 08:53:30,686 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-01 08:53:30,736 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:30,736 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:30.735896 duration_in_ms=50.523
2017-12-01 08:53:30,736 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 08:53:30.736367
2017-12-01 08:53:30,737 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-01 08:53:30,737 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-01 08:53:30,790 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:30,790 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 08:53:30.790111 duration_in_ms=53.744
2017-12-01 08:53:30,791 [salt.state       ][INFO    ][27529] Running state [glance] at time 08:53:30.791134
2017-12-01 08:53:30,791 [salt.state       ][INFO    ][27529] Executing state glusterfs.started for glance
2017-12-01 08:53:30,792 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:30,799 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:30,851 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:30,858 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:30,913 [salt.state       ][INFO    ][27529] Volume glance is already started
2017-12-01 08:53:30,913 [salt.state       ][INFO    ][27529] Completed state [glance] at time 08:53:30.912966 duration_in_ms=121.831
2017-12-01 08:53:30,914 [salt.state       ][INFO    ][27529] Running state [keystone-keys] at time 08:53:30.913747
2017-12-01 08:53:30,914 [salt.state       ][INFO    ][27529] Executing state glusterfs.created for keystone-keys
2017-12-01 08:53:30,914 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:30,922 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:30,971 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:30,979 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:31,031 [salt.state       ][INFO    ][27529] Volume keystone-keys already exists and is started.
2017-12-01 08:53:31,031 [salt.state       ][INFO    ][27529] Completed state [keystone-keys] at time 08:53:31.031371 duration_in_ms=117.623
2017-12-01 08:53:31,035 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 08:53:31.034874
2017-12-01 08:53:31,035 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-01 08:53:31,036 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-01 08:53:31,096 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:31,096 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 08:53:31.096115 duration_in_ms=61.241
2017-12-01 08:53:31,097 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:31.096591
2017-12-01 08:53:31,097 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-01 08:53:31,097 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-01 08:53:31,153 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:31,153 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:31.152858 duration_in_ms=56.266
2017-12-01 08:53:31,153 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 08:53:31.153305
2017-12-01 08:53:31,154 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-01 08:53:31,154 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-01 08:53:31,205 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:31,205 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 08:53:31.205129 duration_in_ms=51.823
2017-12-01 08:53:31,206 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:31.205643
2017-12-01 08:53:31,206 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-01 08:53:31,206 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-01 08:53:31,255 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:31,256 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:31.255639 duration_in_ms=49.995
2017-12-01 08:53:31,256 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 08:53:31.256103
2017-12-01 08:53:31,256 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-01 08:53:31,257 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-01 08:53:31,306 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:31,306 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 08:53:31.305996 duration_in_ms=49.893
2017-12-01 08:53:31,306 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 08:53:31.306452
2017-12-01 08:53:31,307 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-01 08:53:31,307 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-01 08:53:31,360 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:31,361 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 08:53:31.360578 duration_in_ms=54.127
2017-12-01 08:53:31,362 [salt.state       ][INFO    ][27529] Running state [keystone-keys] at time 08:53:31.361727
2017-12-01 08:53:31,362 [salt.state       ][INFO    ][27529] Executing state glusterfs.started for keystone-keys
2017-12-01 08:53:31,362 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:31,371 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:31,425 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:31,434 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:31,486 [salt.state       ][INFO    ][27529] Volume keystone-keys is already started
2017-12-01 08:53:31,486 [salt.state       ][INFO    ][27529] Completed state [keystone-keys] at time 08:53:31.485951 duration_in_ms=124.223
2017-12-01 08:53:31,487 [salt.state       ][INFO    ][27529] Running state [nova_instances] at time 08:53:31.486833
2017-12-01 08:53:31,487 [salt.state       ][INFO    ][27529] Executing state glusterfs.created for nova_instances
2017-12-01 08:53:31,488 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:31,495 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:31,547 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:31,556 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:31,611 [salt.state       ][INFO    ][27529] Volume nova_instances already exists and is started.
2017-12-01 08:53:31,611 [salt.state       ][INFO    ][27529] Completed state [nova_instances] at time 08:53:31.611134 duration_in_ms=124.3
2017-12-01 08:53:31,614 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:31.614456
2017-12-01 08:53:31,615 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-01 08:53:31,615 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-01 08:53:31,668 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:31,668 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:31.668266 duration_in_ms=53.809
2017-12-01 08:53:31,669 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 08:53:31.668719
2017-12-01 08:53:31,669 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-01 08:53:31,669 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-01 08:53:31,720 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:31,720 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 08:53:31.720023 duration_in_ms=51.303
2017-12-01 08:53:31,721 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 08:53:31.720515
2017-12-01 08:53:31,721 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-01 08:53:31,721 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-01 08:53:31,775 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:31,775 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 08:53:31.775227 duration_in_ms=54.71
2017-12-01 08:53:31,776 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 08:53:31.775686
2017-12-01 08:53:31,776 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-01 08:53:31,776 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-01 08:53:31,826 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:31,826 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 08:53:31.826113 duration_in_ms=50.426
2017-12-01 08:53:31,827 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 08:53:31.826527
2017-12-01 08:53:31,827 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-01 08:53:31,827 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-01 08:53:31,877 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:31,878 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 08:53:31.877596 duration_in_ms=51.069
2017-12-01 08:53:31,878 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:31.878104
2017-12-01 08:53:31,878 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-01 08:53:31,879 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-01 08:53:31,929 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:31,929 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:31.929136 duration_in_ms=51.031
2017-12-01 08:53:31,930 [salt.state       ][INFO    ][27529] Running state [nova_instances] at time 08:53:31.930290
2017-12-01 08:53:31,931 [salt.state       ][INFO    ][27529] Executing state glusterfs.started for nova_instances
2017-12-01 08:53:31,931 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:31,938 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:31,987 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:31,996 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:32,050 [salt.state       ][INFO    ][27529] Volume nova_instances is already started
2017-12-01 08:53:32,050 [salt.state       ][INFO    ][27529] Completed state [nova_instances] at time 08:53:32.050308 duration_in_ms=120.017
2017-12-01 08:53:32,051 [salt.state       ][INFO    ][27529] Running state [keystone-credential-keys] at time 08:53:32.051225
2017-12-01 08:53:32,051 [salt.state       ][INFO    ][27529] Executing state glusterfs.created for keystone-credential-keys
2017-12-01 08:53:32,052 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:32,060 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:32,110 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:32,118 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:32,176 [salt.state       ][INFO    ][27529] Volume keystone-credential-keys already exists and is started.
2017-12-01 08:53:32,177 [salt.state       ][INFO    ][27529] Completed state [keystone-credential-keys] at time 08:53:32.176629 duration_in_ms=125.403
2017-12-01 08:53:32,181 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 08:53:32.180891
2017-12-01 08:53:32,181 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-01 08:53:32,182 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-01 08:53:32,238 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:32,238 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 08:53:32.238212 duration_in_ms=57.321
2017-12-01 08:53:32,239 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 08:53:32.238676
2017-12-01 08:53:32,239 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-01 08:53:32,239 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-01 08:53:32,293 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:32,293 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 08:53:32.293191 duration_in_ms=54.513
2017-12-01 08:53:32,294 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:32.293737
2017-12-01 08:53:32,294 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-01 08:53:32,294 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-01 08:53:32,347 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:32,347 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:32.347034 duration_in_ms=53.296
2017-12-01 08:53:32,348 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 08:53:32.347477
2017-12-01 08:53:32,348 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-01 08:53:32,348 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-01 08:53:32,398 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:32,399 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 08:53:32.398653 duration_in_ms=51.175
2017-12-01 08:53:32,399 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:32.399119
2017-12-01 08:53:32,399 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-01 08:53:32,400 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-01 08:53:32,451 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:32,451 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:32.451057 duration_in_ms=51.937
2017-12-01 08:53:32,452 [salt.state       ][INFO    ][27529] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 08:53:32.451603
2017-12-01 08:53:32,452 [salt.state       ][INFO    ][27529] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-01 08:53:32,452 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-01 08:53:32,504 [salt.state       ][INFO    ][27529] unless execution succeeded
2017-12-01 08:53:32,504 [salt.state       ][INFO    ][27529] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 08:53:32.504309 duration_in_ms=52.704
2017-12-01 08:53:32,505 [salt.state       ][INFO    ][27529] Running state [keystone-credential-keys] at time 08:53:32.505373
2017-12-01 08:53:32,506 [salt.state       ][INFO    ][27529] Executing state glusterfs.started for keystone-credential-keys
2017-12-01 08:53:32,506 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:32,514 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:32,571 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --version' in directory '/root'
2017-12-01 08:53:32,579 [salt.loaded.int.module.cmdmod][INFO    ][27529] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 08:53:32,635 [salt.state       ][INFO    ][27529] Volume keystone-credential-keys is already started
2017-12-01 08:53:32,636 [salt.state       ][INFO    ][27529] Completed state [keystone-credential-keys] at time 08:53:32.635664 duration_in_ms=130.29
2017-12-01 08:53:32,639 [salt.minion      ][INFO    ][27529] Returning information for job: 20171201085328573588
2017-12-01 08:53:33,660 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command test.ping with jid 20171201085333651115
2017-12-01 08:53:33,672 [salt.minion      ][INFO    ][28057] Starting a new job with PID 28057
2017-12-01 08:53:33,699 [salt.minion      ][INFO    ][28057] Returning information for job: 20171201085333651115
2017-12-01 08:53:34,357 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command cmd.run with jid 20171201085334344975
2017-12-01 08:53:34,371 [salt.minion      ][INFO    ][28063] Starting a new job with PID 28063
2017-12-01 08:53:34,376 [salt.loaded.int.module.cmdmod][INFO    ][28063] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-01 08:53:34,494 [salt.minion      ][INFO    ][28063] Returning information for job: 20171201085334344975
2017-12-01 09:30:46,047 [salt.utils.schedule][INFO    ][21731] Running scheduled job: __mine_interval
2017-12-01 10:26:16,564 [salt.minion      ][INFO    ][21731] User sudo_ubuntu Executing command cp.push_dir with jid 20171201102616551012
2017-12-01 10:26:16,591 [salt.minion      ][INFO    ][29170] Starting a new job with PID 29170
