2017-11-29 12:12:54,450 [salt.cli.daemons ][WARNING ][2136] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-29 12:13:30,000 [salt.state       ][ERROR   ][3649] No contents found in top file
2017-11-29 12:15:03,651 [salt.utils.parsers][WARNING ][2136] Minion received a SIGTERM. Exiting.
2017-11-29 12:19:31,128 [salt.cli.daemons ][WARNING ][3295] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-29 12:21:48,101 [salt.transport.ipc][ERROR   ][3295] Exception occurred while handling stream: [Errno 0] Success
2017-11-29 12:22:25,741 [py.warnings      ][WARNING ][13645] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-29 12:24:21,187 [salt.loaded.int.module.cmdmod][ERROR   ][13645] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 12:24:21,188 [salt.loaded.int.module.cmdmod][ERROR   ][13645] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 12:24:26,260 [salt.loaded.int.module.cmdmod][ERROR   ][13645] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 12:24:26,260 [salt.loaded.int.module.cmdmod][ERROR   ][13645] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 12:24:30,684 [salt.loaded.int.module.cmdmod][ERROR   ][13645] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 12:24:30,684 [salt.loaded.int.module.cmdmod][ERROR   ][13645] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 12:24:34,953 [salt.loaded.int.module.cmdmod][ERROR   ][13645] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 12:24:34,954 [salt.loaded.int.module.cmdmod][ERROR   ][13645] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 12:24:39,335 [salt.loaded.int.module.cmdmod][ERROR   ][13645] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 12:24:39,335 [salt.loaded.int.module.cmdmod][ERROR   ][13645] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 12:24:42,948 [salt.loaded.int.module.cmdmod][ERROR   ][13645] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-11-29 12:24:45,475 [salt.loaded.int.module.cmdmod][INFO    ][21165] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-29 12:24:45,482 [salt.loaded.int.module.cmdmod][INFO    ][21165] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-29 12:24:45,493 [salt.loaded.int.module.cmdmod][INFO    ][21165] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-29 12:24:45,500 [salt.utils.parsers][WARNING ][3295] Minion received a SIGTERM. Exiting.
2017-11-29 12:24:45,834 [salt.cli.daemons ][INFO    ][21243] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-ovs-ha.local"
2017-11-29 12:24:46,487 [salt.minion      ][INFO    ][21243] Creating minion process manager
2017-11-29 12:24:46,487 [salt.cli.daemons ][WARNING ][21243] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-29 12:24:46,487 [salt.cli.daemons ][INFO    ][21243] The Salt Minion is starting up
2017-11-29 12:24:46,488 [salt.minion      ][INFO    ][21243] Minion is starting as user 'root'
2017-11-29 12:24:46,488 [salt.utils.event ][INFO    ][21243] Starting pull socket on /var/run/salt/minion/minion_event_fd678c5357_pull.ipc
2017-11-29 12:24:47,661 [salt.loaded.int.module.cmdmod][INFO    ][21243] Executing command ['date', '+%z'] in directory '/root'
2017-11-29 12:24:47,673 [salt.utils.schedule][INFO    ][21243] Updating job settings for scheduled job: __mine_interval
2017-11-29 12:24:47,676 [salt.minion      ][INFO    ][21243] Added mine.update to scheduler
2017-11-29 12:24:47,697 [salt.minion      ][INFO    ][21243] Minion is ready to receive requests!
2017-11-29 12:24:48,698 [salt.utils.schedule][INFO    ][21243] Running scheduled job: __mine_interval
2017-11-29 12:25:02,279 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171129122502271895
2017-11-29 12:25:02,290 [salt.minion      ][INFO    ][21343] Starting a new job with PID 21343
2017-11-29 12:25:04,759 [salt.state       ][INFO    ][21343] Loading fresh modules for state activity
2017-11-29 12:25:04,797 [salt.state       ][ERROR   ][21343] No contents found in top file
2017-11-29 12:25:04,798 [salt.utils.extmods][INFO    ][21343] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-29 12:25:04,801 [salt.utils.extmods][INFO    ][21343] Syncing beacons for environment 'base'
2017-11-29 12:25:04,802 [salt.utils.extmods][INFO    ][21343] Loading cache from salt://_beacons, for base)
2017-11-29 12:25:04,802 [salt.fileclient  ][INFO    ][21343] Caching directory '_beacons/' for environment 'base'
2017-11-29 12:25:04,837 [salt.utils.extmods][INFO    ][21343] Syncing modules for environment 'base'
2017-11-29 12:25:04,837 [salt.utils.extmods][INFO    ][21343] Loading cache from salt://_modules, for base)
2017-11-29 12:25:04,837 [salt.fileclient  ][INFO    ][21343] Caching directory '_modules/' for environment 'base'
2017-11-29 12:25:04,890 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-11-29 12:25:04,903 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-29 12:25:04,916 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-29 12:25:04,930 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-29 12:25:04,942 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-29 12:25:04,954 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-29 12:25:04,964 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-29 12:25:04,989 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-29 12:25:05,004 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-29 12:25:05,020 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-29 12:25:05,031 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-29 12:25:05,042 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-29 12:25:05,054 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-29 12:25:05,063 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-29 12:25:05,075 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-29 12:25:05,087 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-29 12:25:05,103 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-29 12:25:05,115 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-29 12:25:05,128 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-29 12:25:05,142 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-29 12:25:05,154 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-29 12:25:05,166 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-29 12:25:05,178 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-29 12:25:05,190 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-29 12:25:05,202 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-29 12:25:05,214 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-29 12:25:05,226 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-29 12:25:05,238 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-29 12:25:05,251 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-29 12:25:05,269 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-29 12:25:05,282 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-29 12:25:05,296 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-29 12:25:05,306 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-29 12:25:05,327 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-29 12:25:05,331 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-29 12:25:05,331 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-11-29 12:25:05,332 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-29 12:25:05,332 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-29 12:25:05,332 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-29 12:25:05,333 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-29 12:25:05,333 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-29 12:25:05,333 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-29 12:25:05,333 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-29 12:25:05,334 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-29 12:25:05,334 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-29 12:25:05,334 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-29 12:25:05,334 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-29 12:25:05,335 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-29 12:25:05,335 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-29 12:25:05,335 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-29 12:25:05,335 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-29 12:25:05,336 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-29 12:25:05,336 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-29 12:25:05,336 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-29 12:25:05,336 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-29 12:25:05,337 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-29 12:25:05,337 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-29 12:25:05,337 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-29 12:25:05,338 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-29 12:25:05,338 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-29 12:25:05,338 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-29 12:25:05,338 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-29 12:25:05,339 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-29 12:25:05,339 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-29 12:25:05,339 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-29 12:25:05,339 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-29 12:25:05,340 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-29 12:25:05,340 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-11-29 12:25:05,340 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-29 12:25:05,340 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-29 12:25:05,346 [salt.utils.extmods][INFO    ][21343] Syncing states for environment 'base'
2017-11-29 12:25:05,346 [salt.utils.extmods][INFO    ][21343] Loading cache from salt://_states, for base)
2017-11-29 12:25:05,346 [salt.fileclient  ][INFO    ][21343] Caching directory '_states/' for environment 'base'
2017-11-29 12:25:05,407 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-11-29 12:25:05,421 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-29 12:25:05,434 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-29 12:25:05,442 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-29 12:25:05,454 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-29 12:25:05,469 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-29 12:25:05,481 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-29 12:25:05,492 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-29 12:25:05,502 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-29 12:25:05,514 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-11-29 12:25:05,524 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-29 12:25:05,535 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-29 12:25:05,550 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-29 12:25:05,560 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-29 12:25:05,571 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-29 12:25:05,584 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-29 12:25:05,594 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-29 12:25:05,608 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-29 12:25:05,618 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-29 12:25:05,627 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-29 12:25:05,635 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-29 12:25:05,651 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-29 12:25:05,663 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-29 12:25:05,675 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-29 12:25:05,693 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-29 12:25:05,705 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-29 12:25:05,728 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-29 12:25:05,740 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-29 12:25:05,753 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-29 12:25:05,763 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-29 12:25:05,775 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-29 12:25:05,784 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-29 12:25:05,789 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-11-29 12:25:05,789 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-29 12:25:05,789 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-29 12:25:05,790 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-29 12:25:05,790 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-29 12:25:05,790 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-29 12:25:05,791 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-29 12:25:05,791 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-29 12:25:05,791 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-29 12:25:05,791 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-11-29 12:25:05,792 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-29 12:25:05,792 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-29 12:25:05,792 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-29 12:25:05,792 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-29 12:25:05,793 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-29 12:25:05,793 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-29 12:25:05,793 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-29 12:25:05,793 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-29 12:25:05,794 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-29 12:25:05,794 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-29 12:25:05,794 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-29 12:25:05,794 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-29 12:25:05,795 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-29 12:25:05,795 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-29 12:25:05,795 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-29 12:25:05,795 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-29 12:25:05,796 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-29 12:25:05,796 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-29 12:25:05,796 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-29 12:25:05,796 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-29 12:25:05,797 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-29 12:25:05,797 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-29 12:25:05,797 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-29 12:25:05,800 [salt.utils.extmods][INFO    ][21343] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-29 12:25:05,803 [salt.utils.extmods][INFO    ][21343] Syncing sdb for environment 'base'
2017-11-29 12:25:05,803 [salt.utils.extmods][INFO    ][21343] Loading cache from salt://_sdb, for base)
2017-11-29 12:25:05,803 [salt.fileclient  ][INFO    ][21343] Caching directory '_sdb/' for environment 'base'
2017-11-29 12:25:05,842 [salt.utils.extmods][INFO    ][21343] Syncing grains for environment 'base'
2017-11-29 12:25:05,842 [salt.utils.extmods][INFO    ][21343] Loading cache from salt://_grains, for base)
2017-11-29 12:25:05,842 [salt.fileclient  ][INFO    ][21343] Caching directory '_grains/' for environment 'base'
2017-11-29 12:25:05,876 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-29 12:25:05,887 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-29 12:25:05,896 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-29 12:25:05,904 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-29 12:25:05,913 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-29 12:25:05,921 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-29 12:25:05,930 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-29 12:25:05,941 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-29 12:25:05,953 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-29 12:25:05,965 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-29 12:25:05,977 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-29 12:25:06,225 [salt.fileclient  ][INFO    ][21343] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-29 12:25:06,229 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-29 12:25:06,229 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-29 12:25:06,229 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-29 12:25:06,230 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-29 12:25:06,230 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-29 12:25:06,230 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-29 12:25:06,230 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-29 12:25:06,230 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-29 12:25:06,231 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-29 12:25:06,231 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-29 12:25:06,231 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-29 12:25:06,231 [salt.utils.extmods][INFO    ][21343] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-29 12:25:06,233 [salt.utils.extmods][INFO    ][21343] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-29 12:25:06,236 [salt.utils.extmods][INFO    ][21343] Syncing renderers for environment 'base'
2017-11-29 12:25:06,236 [salt.utils.extmods][INFO    ][21343] Loading cache from salt://_renderers, for base)
2017-11-29 12:25:06,236 [salt.fileclient  ][INFO    ][21343] Caching directory '_renderers/' for environment 'base'
2017-11-29 12:25:06,274 [salt.utils.extmods][INFO    ][21343] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-29 12:25:06,276 [salt.utils.extmods][INFO    ][21343] Syncing returners for environment 'base'
2017-11-29 12:25:06,277 [salt.utils.extmods][INFO    ][21343] Loading cache from salt://_returners, for base)
2017-11-29 12:25:06,277 [salt.fileclient  ][INFO    ][21343] Caching directory '_returners/' for environment 'base'
2017-11-29 12:25:06,314 [salt.utils.extmods][INFO    ][21343] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-29 12:25:06,317 [salt.utils.extmods][INFO    ][21343] Syncing output for environment 'base'
2017-11-29 12:25:06,317 [salt.utils.extmods][INFO    ][21343] Loading cache from salt://_output, for base)
2017-11-29 12:25:06,317 [salt.fileclient  ][INFO    ][21343] Caching directory '_output/' for environment 'base'
2017-11-29 12:25:06,352 [salt.utils.extmods][INFO    ][21343] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-29 12:25:06,355 [salt.utils.extmods][INFO    ][21343] Syncing utils for environment 'base'
2017-11-29 12:25:06,355 [salt.utils.extmods][INFO    ][21343] Loading cache from salt://_utils, for base)
2017-11-29 12:25:06,355 [salt.fileclient  ][INFO    ][21343] Caching directory '_utils/' for environment 'base'
2017-11-29 12:25:06,408 [salt.utils.extmods][INFO    ][21343] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-29 12:25:06,411 [salt.utils.extmods][INFO    ][21343] Syncing log_handlers for environment 'base'
2017-11-29 12:25:06,412 [salt.utils.extmods][INFO    ][21343] Loading cache from salt://_log_handlers, for base)
2017-11-29 12:25:06,412 [salt.fileclient  ][INFO    ][21343] Caching directory '_log_handlers/' for environment 'base'
2017-11-29 12:25:06,458 [salt.utils.extmods][INFO    ][21343] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-29 12:25:06,461 [salt.utils.extmods][INFO    ][21343] Syncing proxy for environment 'base'
2017-11-29 12:25:06,461 [salt.utils.extmods][INFO    ][21343] Loading cache from salt://_proxy, for base)
2017-11-29 12:25:06,461 [salt.fileclient  ][INFO    ][21343] Caching directory '_proxy/' for environment 'base'
2017-11-29 12:25:06,498 [salt.utils.extmods][INFO    ][21343] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-29 12:25:06,501 [salt.utils.extmods][INFO    ][21343] Syncing engines for environment 'base'
2017-11-29 12:25:06,501 [salt.utils.extmods][INFO    ][21343] Loading cache from salt://_engines, for base)
2017-11-29 12:25:06,501 [salt.fileclient  ][INFO    ][21343] Caching directory '_engines/' for environment 'base'
2017-11-29 12:25:06,537 [salt.minion      ][INFO    ][21343] Returning information for job: 20171129122502271895
2017-11-29 12:25:08,307 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command state.sls with jid 20171129122507806519
2017-11-29 12:25:08,317 [salt.minion      ][INFO    ][21439] Starting a new job with PID 21439
2017-11-29 12:25:08,938 [salt.state       ][INFO    ][21439] Loading fresh modules for state activity
2017-11-29 12:25:08,969 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-29 12:25:08,990 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-29 12:25:09,087 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:09,172 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-29 12:25:09,186 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-29 12:25:09,219 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:09,284 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-29 12:25:09,304 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-29 12:25:09,363 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-29 12:25:09,385 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-29 12:25:09,400 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 12:25:09,418 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-29 12:25:09,427 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-29 12:25:09,450 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-29 12:25:09,468 [py.warnings      ][WARNING ][21439] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-29 12:25:09,468 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'salt-minion --version' in directory '/root'
2017-11-29 12:25:09,729 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-29 12:25:09,753 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-29 12:25:09,765 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-29 12:25:09,779 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-29 12:25:09,822 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-29 12:25:09,838 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-29 12:25:09,863 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-11-29 12:25:09,877 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-11-29 12:25:09,898 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-29 12:25:09,934 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-29 12:25:10,003 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-29 12:25:10,025 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:10,087 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-29 12:25:10,467 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-29 12:25:10,526 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-29 12:25:10,546 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-29 12:25:10,559 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 12:25:10,577 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-29 12:25:10,586 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-29 12:25:10,609 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-29 12:25:10,628 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'salt-minion --version' in directory '/root'
2017-11-29 12:25:10,894 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-29 12:25:10,914 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-29 12:25:10,925 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-29 12:25:10,938 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-29 12:25:10,982 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-29 12:25:10,996 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-29 12:25:11,017 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-11-29 12:25:11,030 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-11-29 12:25:11,051 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-29 12:25:11,092 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-29 12:25:11,189 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-29 12:25:11,273 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:11,661 [salt.state       ][INFO    ][21439] Running state [salt-minion] at time 12:25:11.661451
2017-11-29 12:25:11,662 [salt.state       ][INFO    ][21439] Executing state pkg.installed for salt-minion
2017-11-29 12:25:11,662 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:25:11,925 [salt.state       ][INFO    ][21439] Package salt-minion is already installed
2017-11-29 12:25:11,926 [salt.state       ][INFO    ][21439] Completed state [salt-minion] at time 12:25:11.925609 duration_in_ms=264.158
2017-11-29 12:25:11,926 [salt.state       ][INFO    ][21439] Running state [salt_minion_dependency_packages] at time 12:25:11.925909
2017-11-29 12:25:11,926 [salt.state       ][INFO    ][21439] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-29 12:25:11,930 [salt.state       ][INFO    ][21439] All specified packages are already installed
2017-11-29 12:25:11,930 [salt.state       ][INFO    ][21439] Completed state [salt_minion_dependency_packages] at time 12:25:11.930037 duration_in_ms=4.116
2017-11-29 12:25:11,932 [salt.state       ][INFO    ][21439] Running state [/etc/salt/minion.d/minion.conf] at time 12:25:11.931665
2017-11-29 12:25:11,932 [salt.state       ][INFO    ][21439] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-29 12:25:11,949 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-29 12:25:12,013 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:12,069 [salt.fileclient  ][INFO    ][21439] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-29 12:25:12,119 [salt.state       ][INFO    ][21439] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-29 12:25:12,119 [salt.state       ][INFO    ][21439] Completed state [/etc/salt/minion.d/minion.conf] at time 12:25:12.119278 duration_in_ms=187.612
2017-11-29 12:25:12,120 [salt.state       ][INFO    ][21439] Running state [/etc/salt/minion.d/_virt.conf] at time 12:25:12.119707
2017-11-29 12:25:12,120 [salt.state       ][INFO    ][21439] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-29 12:25:12,121 [salt.state       ][INFO    ][21439] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-29 12:25:12,121 [salt.state       ][INFO    ][21439] Completed state [/etc/salt/minion.d/_virt.conf] at time 12:25:12.120722 duration_in_ms=1.014
2017-11-29 12:25:12,123 [salt.state       ][INFO    ][21439] Running state [salt-minion] at time 12:25:12.122486
2017-11-29 12:25:12,123 [salt.state       ][INFO    ][21439] Executing state service.running for salt-minion
2017-11-29 12:25:12,123 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-29 12:25:12,138 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-29 12:25:12,146 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-29 12:25:12,154 [salt.state       ][INFO    ][21439] The service salt-minion is already running
2017-11-29 12:25:12,154 [salt.state       ][INFO    ][21439] Completed state [salt-minion] at time 12:25:12.153850 duration_in_ms=31.363
2017-11-29 12:25:12,155 [salt.state       ][INFO    ][21439] Running state [/etc/salt/grains.d] at time 12:25:12.155394
2017-11-29 12:25:12,156 [salt.state       ][INFO    ][21439] Executing state file.directory for /etc/salt/grains.d
2017-11-29 12:25:12,156 [salt.state       ][INFO    ][21439] Directory /etc/salt/grains.d is in the correct state
2017-11-29 12:25:12,156 [salt.state       ][INFO    ][21439] Completed state [/etc/salt/grains.d] at time 12:25:12.156339 duration_in_ms=0.945
2017-11-29 12:25:12,157 [salt.state       ][INFO    ][21439] Running state [/etc/salt/grains] at time 12:25:12.156835
2017-11-29 12:25:12,157 [salt.state       ][INFO    ][21439] Executing state file.managed for /etc/salt/grains
2017-11-29 12:25:12,157 [salt.state       ][INFO    ][21439] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-29 12:25:12,158 [salt.state       ][INFO    ][21439] Completed state [/etc/salt/grains] at time 12:25:12.157581 duration_in_ms=0.746
2017-11-29 12:25:12,158 [salt.state       ][INFO    ][21439] Running state [/etc/salt/grains.d/placeholder] at time 12:25:12.157912
2017-11-29 12:25:12,158 [salt.state       ][INFO    ][21439] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-29 12:25:12,158 [salt.state       ][INFO    ][21439] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-29 12:25:12,159 [salt.state       ][INFO    ][21439] Completed state [/etc/salt/grains.d/placeholder] at time 12:25:12.158543 duration_in_ms=0.631
2017-11-29 12:25:12,159 [salt.state       ][INFO    ][21439] Running state [/etc/salt/grains.d/sphinx] at time 12:25:12.158894
2017-11-29 12:25:12,159 [salt.state       ][INFO    ][21439] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-29 12:25:12,161 [salt.state       ][INFO    ][21439] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.141
               - 192.168.11.2
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-29 12:25:12,161 [salt.state       ][INFO    ][21439] Completed state [/etc/salt/grains.d/sphinx] at time 12:25:12.160668 duration_in_ms=1.774
2017-11-29 12:25:12,161 [salt.state       ][INFO    ][21439] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:25:12.161414
2017-11-29 12:25:12,162 [salt.state       ][INFO    ][21439] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:12,162 [salt.state       ][INFO    ][21439] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:12,162 [salt.state       ][INFO    ][21439] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:25:12.161941 duration_in_ms=0.527
2017-11-29 12:25:12,162 [salt.state       ][INFO    ][21439] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:25:12.162090
2017-11-29 12:25:12,162 [salt.state       ][INFO    ][21439] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:12,163 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-29 12:25:12,238 [salt.state       ][INFO    ][21439] {'pid': 21487, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-29 12:25:12,238 [salt.state       ][INFO    ][21439] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:25:12.238381 duration_in_ms=76.291
2017-11-29 12:25:12,239 [salt.state       ][INFO    ][21439] Running state [/etc/salt/grains.d/dns_records] at time 12:25:12.238928
2017-11-29 12:25:12,239 [salt.state       ][INFO    ][21439] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-29 12:25:12,240 [salt.state       ][INFO    ][21439] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-29 12:25:12,240 [salt.state       ][INFO    ][21439] Completed state [/etc/salt/grains.d/dns_records] at time 12:25:12.240180 duration_in_ms=1.252
2017-11-29 12:25:12,241 [salt.state       ][INFO    ][21439] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 12:25:12.240997
2017-11-29 12:25:12,241 [salt.state       ][INFO    ][21439] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:12,241 [salt.state       ][INFO    ][21439] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:12,242 [salt.state       ][INFO    ][21439] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 12:25:12.241613 duration_in_ms=0.615
2017-11-29 12:25:12,242 [salt.state       ][INFO    ][21439] Running state [/etc/salt/grains.d/salt] at time 12:25:12.241975
2017-11-29 12:25:12,242 [salt.state       ][INFO    ][21439] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-29 12:25:12,243 [salt.state       ][INFO    ][21439] File /etc/salt/grains.d/salt is in the correct state
2017-11-29 12:25:12,243 [salt.state       ][INFO    ][21439] Completed state [/etc/salt/grains.d/salt] at time 12:25:12.242970 duration_in_ms=0.995
2017-11-29 12:25:12,244 [salt.state       ][INFO    ][21439] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 12:25:12.243684
2017-11-29 12:25:12,244 [salt.state       ][INFO    ][21439] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:12,244 [salt.state       ][INFO    ][21439] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:12,244 [salt.state       ][INFO    ][21439] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 12:25:12.244251 duration_in_ms=0.566
2017-11-29 12:25:12,246 [salt.state       ][INFO    ][21439] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:25:12.245848
2017-11-29 12:25:12,246 [salt.state       ][INFO    ][21439] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-29 12:25:12,246 [salt.state       ][INFO    ][21439] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-29 12:25:12,246 [salt.state       ][INFO    ][21439] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:25:12.246435 duration_in_ms=0.587
2017-11-29 12:25:12,247 [salt.state       ][INFO    ][21439] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:25:12.246587
2017-11-29 12:25:12,247 [salt.state       ][INFO    ][21439] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-29 12:25:12,248 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-29 12:25:12,255 [salt.state       ][INFO    ][21439] {'pid': 21489, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-29 12:25:12,255 [salt.state       ][INFO    ][21439] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:25:12.255026 duration_in_ms=8.438
2017-11-29 12:25:12,256 [salt.state       ][INFO    ][21439] Running state [mine.update] at time 12:25:12.255732
2017-11-29 12:25:12,256 [salt.state       ][INFO    ][21439] Executing state module.wait for mine.update
2017-11-29 12:25:12,256 [salt.state       ][INFO    ][21439] No changes made for mine.update
2017-11-29 12:25:12,256 [salt.state       ][INFO    ][21439] Completed state [mine.update] at time 12:25:12.256326 duration_in_ms=0.594
2017-11-29 12:25:12,257 [salt.state       ][INFO    ][21439] Running state [mine.update] at time 12:25:12.256476
2017-11-29 12:25:12,257 [salt.state       ][INFO    ][21439] Executing state module.mod_watch for mine.update
2017-11-29 12:25:12,775 [salt.state       ][INFO    ][21439] {'ret': True}
2017-11-29 12:25:12,775 [salt.state       ][INFO    ][21439] Completed state [mine.update] at time 12:25:12.774934 duration_in_ms=518.457
2017-11-29 12:25:12,775 [salt.state       ][INFO    ][21439] Running state [ca-certificates] at time 12:25:12.775221
2017-11-29 12:25:12,775 [salt.state       ][INFO    ][21439] Executing state pkg.installed for ca-certificates
2017-11-29 12:25:12,779 [salt.state       ][INFO    ][21439] Package ca-certificates is already installed
2017-11-29 12:25:12,780 [salt.state       ][INFO    ][21439] Completed state [ca-certificates] at time 12:25:12.779630 duration_in_ms=4.409
2017-11-29 12:25:12,780 [salt.state       ][INFO    ][21439] Running state [update-ca-certificates] at time 12:25:12.780303
2017-11-29 12:25:12,781 [salt.state       ][INFO    ][21439] Executing state cmd.wait for update-ca-certificates
2017-11-29 12:25:12,781 [salt.state       ][INFO    ][21439] No changes made for update-ca-certificates
2017-11-29 12:25:12,781 [salt.state       ][INFO    ][21439] Completed state [update-ca-certificates] at time 12:25:12.780879 duration_in_ms=0.576
2017-11-29 12:25:12,781 [salt.state       ][INFO    ][21439] Running state [libvirt-dev] at time 12:25:12.781085
2017-11-29 12:25:12,781 [salt.state       ][INFO    ][21439] Executing state pkg.installed for libvirt-dev
2017-11-29 12:25:12,785 [salt.state       ][INFO    ][21439] Package libvirt-dev is already installed
2017-11-29 12:25:12,785 [salt.state       ][INFO    ][21439] Completed state [libvirt-dev] at time 12:25:12.785001 duration_in_ms=3.916
2017-11-29 12:25:12,785 [salt.state       ][INFO    ][21439] Running state [pkg-config] at time 12:25:12.785190
2017-11-29 12:25:12,785 [salt.state       ][INFO    ][21439] Executing state pkg.installed for pkg-config
2017-11-29 12:25:12,789 [salt.state       ][INFO    ][21439] Package pkg-config is already installed
2017-11-29 12:25:12,789 [salt.state       ][INFO    ][21439] Completed state [pkg-config] at time 12:25:12.789305 duration_in_ms=4.115
2017-11-29 12:25:12,790 [salt.state       ][INFO    ][21439] Running state [virtng.init] at time 12:25:12.789492
2017-11-29 12:25:12,790 [salt.state       ][INFO    ][21439] Executing state module.run for virtng.init
2017-11-29 12:25:12,892 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command ['git', '--version'] in directory '/root'
2017-11-29 12:25:12,947 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:12,963 [salt.state       ][INFO    ][21439] unless execution succeeded
2017-11-29 12:25:12,963 [salt.state       ][INFO    ][21439] Completed state [virtng.init] at time 12:25:12.963432 duration_in_ms=173.939
2017-11-29 12:25:12,964 [salt.state       ][INFO    ][21439] Running state [virt.set_autostart] at time 12:25:12.963686
2017-11-29 12:25:12,964 [salt.state       ][INFO    ][21439] Executing state module.run for virt.set_autostart
2017-11-29 12:25:12,967 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:12,981 [salt.state       ][INFO    ][21439] unless execution succeeded
2017-11-29 12:25:12,982 [salt.state       ][INFO    ][21439] Completed state [virt.set_autostart] at time 12:25:12.981692 duration_in_ms=18.005
2017-11-29 12:25:12,982 [salt.state       ][INFO    ][21439] Running state [virtng.init] at time 12:25:12.981945
2017-11-29 12:25:12,982 [salt.state       ][INFO    ][21439] Executing state module.run for virtng.init
2017-11-29 12:25:12,985 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:13,001 [salt.state       ][INFO    ][21439] unless execution succeeded
2017-11-29 12:25:13,002 [salt.state       ][INFO    ][21439] Completed state [virtng.init] at time 12:25:13.001503 duration_in_ms=19.557
2017-11-29 12:25:13,002 [salt.state       ][INFO    ][21439] Running state [virt.set_autostart] at time 12:25:13.001748
2017-11-29 12:25:13,002 [salt.state       ][INFO    ][21439] Executing state module.run for virt.set_autostart
2017-11-29 12:25:13,005 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:13,020 [salt.state       ][INFO    ][21439] unless execution succeeded
2017-11-29 12:25:13,020 [salt.state       ][INFO    ][21439] Completed state [virt.set_autostart] at time 12:25:13.019942 duration_in_ms=18.193
2017-11-29 12:25:13,020 [salt.state       ][INFO    ][21439] Running state [virtng.init] at time 12:25:13.020201
2017-11-29 12:25:13,020 [salt.state       ][INFO    ][21439] Executing state module.run for virtng.init
2017-11-29 12:25:13,023 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:13,039 [salt.state       ][INFO    ][21439] unless execution succeeded
2017-11-29 12:25:13,039 [salt.state       ][INFO    ][21439] Completed state [virtng.init] at time 12:25:13.039166 duration_in_ms=18.965
2017-11-29 12:25:13,039 [salt.state       ][INFO    ][21439] Running state [virt.set_autostart] at time 12:25:13.039429
2017-11-29 12:25:13,040 [salt.state       ][INFO    ][21439] Executing state module.run for virt.set_autostart
2017-11-29 12:25:13,042 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:13,057 [salt.state       ][INFO    ][21439] unless execution succeeded
2017-11-29 12:25:13,058 [salt.state       ][INFO    ][21439] Completed state [virt.set_autostart] at time 12:25:13.057532 duration_in_ms=18.103
2017-11-29 12:25:13,058 [salt.state       ][INFO    ][21439] Running state [virtng.init] at time 12:25:13.057787
2017-11-29 12:25:13,058 [salt.state       ][INFO    ][21439] Executing state module.run for virtng.init
2017-11-29 12:25:13,061 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:13,077 [salt.state       ][INFO    ][21439] unless execution succeeded
2017-11-29 12:25:13,078 [salt.state       ][INFO    ][21439] Completed state [virtng.init] at time 12:25:13.077498 duration_in_ms=19.71
2017-11-29 12:25:13,078 [salt.state       ][INFO    ][21439] Running state [virt.set_autostart] at time 12:25:13.077730
2017-11-29 12:25:13,078 [salt.state       ][INFO    ][21439] Executing state module.run for virt.set_autostart
2017-11-29 12:25:13,080 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:13,095 [salt.state       ][INFO    ][21439] unless execution succeeded
2017-11-29 12:25:13,095 [salt.state       ][INFO    ][21439] Completed state [virt.set_autostart] at time 12:25:13.094985 duration_in_ms=17.254
2017-11-29 12:25:13,095 [salt.state       ][INFO    ][21439] Running state [virtng.init] at time 12:25:13.095208
2017-11-29 12:25:13,095 [salt.state       ][INFO    ][21439] Executing state module.run for virtng.init
2017-11-29 12:25:13,098 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:13,112 [salt.state       ][INFO    ][21439] unless execution succeeded
2017-11-29 12:25:13,112 [salt.state       ][INFO    ][21439] Completed state [virtng.init] at time 12:25:13.112174 duration_in_ms=16.966
2017-11-29 12:25:13,112 [salt.state       ][INFO    ][21439] Running state [virt.set_autostart] at time 12:25:13.112403
2017-11-29 12:25:13,113 [salt.state       ][INFO    ][21439] Executing state module.run for virt.set_autostart
2017-11-29 12:25:13,115 [salt.loaded.int.module.cmdmod][INFO    ][21439] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:13,130 [salt.state       ][INFO    ][21439] unless execution succeeded
2017-11-29 12:25:13,131 [salt.state       ][INFO    ][21439] Completed state [virt.set_autostart] at time 12:25:13.130608 duration_in_ms=18.203
2017-11-29 12:25:13,133 [salt.minion      ][INFO    ][21439] Returning information for job: 20171129122507806519
2017-11-29 12:25:38,776 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command state.sls with jid 20171129122538764378
2017-11-29 12:25:38,786 [salt.minion      ][INFO    ][21545] Starting a new job with PID 21545
2017-11-29 12:25:41,446 [salt.state       ][INFO    ][21545] Loading fresh modules for state activity
2017-11-29 12:25:41,476 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-29 12:25:41,495 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-29 12:25:41,555 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:41,641 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-29 12:25:41,658 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-29 12:25:41,689 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:41,761 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-29 12:25:41,783 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-29 12:25:41,841 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-29 12:25:41,861 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-29 12:25:41,875 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 12:25:41,890 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-29 12:25:41,900 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-29 12:25:41,922 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-29 12:25:41,941 [py.warnings      ][WARNING ][21545] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-29 12:25:41,941 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'salt-minion --version' in directory '/root'
2017-11-29 12:25:42,195 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-29 12:25:42,215 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-29 12:25:42,229 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-29 12:25:42,242 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-29 12:25:42,286 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-29 12:25:42,302 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-29 12:25:42,327 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-11-29 12:25:42,342 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-11-29 12:25:42,362 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-29 12:25:42,401 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-29 12:25:42,469 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-29 12:25:42,494 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:42,564 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-29 12:25:42,584 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-29 12:25:42,642 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-29 12:25:42,662 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-29 12:25:42,680 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 12:25:42,699 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-29 12:25:42,707 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-29 12:25:42,731 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-29 12:25:42,750 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'salt-minion --version' in directory '/root'
2017-11-29 12:25:43,002 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-29 12:25:43,021 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-29 12:25:43,035 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-29 12:25:43,051 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-29 12:25:43,094 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-29 12:25:43,110 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-29 12:25:43,137 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-11-29 12:25:43,150 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-11-29 12:25:43,171 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-29 12:25:43,212 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-29 12:25:43,289 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-29 12:25:43,371 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:43,705 [salt.state       ][INFO    ][21545] Running state [salt-minion] at time 12:25:43.704579
2017-11-29 12:25:43,705 [salt.state       ][INFO    ][21545] Executing state pkg.installed for salt-minion
2017-11-29 12:25:43,705 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:25:43,990 [salt.state       ][INFO    ][21545] Package salt-minion is already installed
2017-11-29 12:25:43,991 [salt.state       ][INFO    ][21545] Completed state [salt-minion] at time 12:25:43.990776 duration_in_ms=286.198
2017-11-29 12:25:43,991 [salt.state       ][INFO    ][21545] Running state [salt_minion_dependency_packages] at time 12:25:43.991074
2017-11-29 12:25:43,991 [salt.state       ][INFO    ][21545] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-29 12:25:43,995 [salt.state       ][INFO    ][21545] All specified packages are already installed
2017-11-29 12:25:43,995 [salt.state       ][INFO    ][21545] Completed state [salt_minion_dependency_packages] at time 12:25:43.995254 duration_in_ms=4.18
2017-11-29 12:25:43,997 [salt.state       ][INFO    ][21545] Running state [/etc/salt/minion.d/minion.conf] at time 12:25:43.996966
2017-11-29 12:25:43,997 [salt.state       ][INFO    ][21545] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-29 12:25:44,019 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-29 12:25:44,078 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:44,135 [salt.fileclient  ][INFO    ][21545] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-29 12:25:44,183 [salt.state       ][INFO    ][21545] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-29 12:25:44,183 [salt.state       ][INFO    ][21545] Completed state [/etc/salt/minion.d/minion.conf] at time 12:25:44.182905 duration_in_ms=185.939
2017-11-29 12:25:44,183 [salt.state       ][INFO    ][21545] Running state [/etc/salt/minion.d/_virt.conf] at time 12:25:44.183298
2017-11-29 12:25:44,184 [salt.state       ][INFO    ][21545] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-29 12:25:44,184 [salt.state       ][INFO    ][21545] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-29 12:25:44,184 [salt.state       ][INFO    ][21545] Completed state [/etc/salt/minion.d/_virt.conf] at time 12:25:44.184344 duration_in_ms=1.046
2017-11-29 12:25:44,186 [salt.state       ][INFO    ][21545] Running state [salt-minion] at time 12:25:44.186083
2017-11-29 12:25:44,186 [salt.state       ][INFO    ][21545] Executing state service.running for salt-minion
2017-11-29 12:25:44,187 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-29 12:25:44,202 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-29 12:25:44,210 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-29 12:25:44,218 [salt.state       ][INFO    ][21545] The service salt-minion is already running
2017-11-29 12:25:44,218 [salt.state       ][INFO    ][21545] Completed state [salt-minion] at time 12:25:44.218206 duration_in_ms=32.122
2017-11-29 12:25:44,220 [salt.state       ][INFO    ][21545] Running state [/etc/salt/grains.d] at time 12:25:44.219764
2017-11-29 12:25:44,220 [salt.state       ][INFO    ][21545] Executing state file.directory for /etc/salt/grains.d
2017-11-29 12:25:44,221 [salt.state       ][INFO    ][21545] Directory /etc/salt/grains.d is in the correct state
2017-11-29 12:25:44,221 [salt.state       ][INFO    ][21545] Completed state [/etc/salt/grains.d] at time 12:25:44.220809 duration_in_ms=1.046
2017-11-29 12:25:44,221 [salt.state       ][INFO    ][21545] Running state [/etc/salt/grains] at time 12:25:44.221445
2017-11-29 12:25:44,222 [salt.state       ][INFO    ][21545] Executing state file.managed for /etc/salt/grains
2017-11-29 12:25:44,222 [salt.state       ][INFO    ][21545] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-29 12:25:44,222 [salt.state       ][INFO    ][21545] Completed state [/etc/salt/grains] at time 12:25:44.222213 duration_in_ms=0.768
2017-11-29 12:25:44,223 [salt.state       ][INFO    ][21545] Running state [/etc/salt/grains.d/placeholder] at time 12:25:44.222591
2017-11-29 12:25:44,223 [salt.state       ][INFO    ][21545] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-29 12:25:44,223 [salt.state       ][INFO    ][21545] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-29 12:25:44,223 [salt.state       ][INFO    ][21545] Completed state [/etc/salt/grains.d/placeholder] at time 12:25:44.223333 duration_in_ms=0.742
2017-11-29 12:25:44,224 [salt.state       ][INFO    ][21545] Running state [/etc/salt/grains.d/sphinx] at time 12:25:44.223717
2017-11-29 12:25:44,224 [salt.state       ][INFO    ][21545] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-29 12:25:44,225 [salt.state       ][INFO    ][21545] File /etc/salt/grains.d/sphinx is in the correct state
2017-11-29 12:25:44,225 [salt.state       ][INFO    ][21545] Completed state [/etc/salt/grains.d/sphinx] at time 12:25:44.224840 duration_in_ms=1.124
2017-11-29 12:25:44,226 [salt.state       ][INFO    ][21545] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.225660
2017-11-29 12:25:44,226 [salt.state       ][INFO    ][21545] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:44,226 [salt.state       ][INFO    ][21545] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:44,226 [salt.state       ][INFO    ][21545] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.226254 duration_in_ms=0.593
2017-11-29 12:25:44,227 [salt.state       ][INFO    ][21545] Running state [/etc/salt/grains.d/dns_records] at time 12:25:44.226618
2017-11-29 12:25:44,227 [salt.state       ][INFO    ][21545] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-29 12:25:44,227 [salt.state       ][INFO    ][21545] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-29 12:25:44,228 [salt.state       ][INFO    ][21545] Completed state [/etc/salt/grains.d/dns_records] at time 12:25:44.227644 duration_in_ms=1.025
2017-11-29 12:25:44,228 [salt.state       ][INFO    ][21545] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.228399
2017-11-29 12:25:44,229 [salt.state       ][INFO    ][21545] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:44,229 [salt.state       ][INFO    ][21545] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:44,229 [salt.state       ][INFO    ][21545] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.229006 duration_in_ms=0.607
2017-11-29 12:25:44,229 [salt.state       ][INFO    ][21545] Running state [/etc/salt/grains.d/salt] at time 12:25:44.229390
2017-11-29 12:25:44,230 [salt.state       ][INFO    ][21545] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-29 12:25:44,230 [salt.state       ][INFO    ][21545] File /etc/salt/grains.d/salt is in the correct state
2017-11-29 12:25:44,230 [salt.state       ][INFO    ][21545] Completed state [/etc/salt/grains.d/salt] at time 12:25:44.230425 duration_in_ms=1.036
2017-11-29 12:25:44,231 [salt.state       ][INFO    ][21545] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.231159
2017-11-29 12:25:44,231 [salt.state       ][INFO    ][21545] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:44,232 [salt.state       ][INFO    ][21545] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:44,232 [salt.state       ][INFO    ][21545] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.231740 duration_in_ms=0.58
2017-11-29 12:25:44,233 [salt.state       ][INFO    ][21545] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:25:44.233382
2017-11-29 12:25:44,234 [salt.state       ][INFO    ][21545] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-29 12:25:44,234 [salt.state       ][INFO    ][21545] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-29 12:25:44,234 [salt.state       ][INFO    ][21545] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:25:44.233993 duration_in_ms=0.611
2017-11-29 12:25:44,235 [salt.state       ][INFO    ][21545] Running state [mine.update] at time 12:25:44.234540
2017-11-29 12:25:44,235 [salt.state       ][INFO    ][21545] Executing state module.wait for mine.update
2017-11-29 12:25:44,235 [salt.state       ][INFO    ][21545] No changes made for mine.update
2017-11-29 12:25:44,235 [salt.state       ][INFO    ][21545] Completed state [mine.update] at time 12:25:44.235086 duration_in_ms=0.546
2017-11-29 12:25:44,235 [salt.state       ][INFO    ][21545] Running state [ca-certificates] at time 12:25:44.235260
2017-11-29 12:25:44,235 [salt.state       ][INFO    ][21545] Executing state pkg.installed for ca-certificates
2017-11-29 12:25:44,239 [salt.state       ][INFO    ][21545] Package ca-certificates is already installed
2017-11-29 12:25:44,240 [salt.state       ][INFO    ][21545] Completed state [ca-certificates] at time 12:25:44.239504 duration_in_ms=4.244
2017-11-29 12:25:44,240 [salt.state       ][INFO    ][21545] Running state [update-ca-certificates] at time 12:25:44.240085
2017-11-29 12:25:44,240 [salt.state       ][INFO    ][21545] Executing state cmd.wait for update-ca-certificates
2017-11-29 12:25:44,241 [salt.state       ][INFO    ][21545] No changes made for update-ca-certificates
2017-11-29 12:25:44,241 [salt.state       ][INFO    ][21545] Completed state [update-ca-certificates] at time 12:25:44.240668 duration_in_ms=0.583
2017-11-29 12:25:44,241 [salt.state       ][INFO    ][21545] Running state [libvirt-dev] at time 12:25:44.240845
2017-11-29 12:25:44,241 [salt.state       ][INFO    ][21545] Executing state pkg.installed for libvirt-dev
2017-11-29 12:25:44,245 [salt.state       ][INFO    ][21545] Package libvirt-dev is already installed
2017-11-29 12:25:44,245 [salt.state       ][INFO    ][21545] Completed state [libvirt-dev] at time 12:25:44.244803 duration_in_ms=3.958
2017-11-29 12:25:44,245 [salt.state       ][INFO    ][21545] Running state [pkg-config] at time 12:25:44.245021
2017-11-29 12:25:44,245 [salt.state       ][INFO    ][21545] Executing state pkg.installed for pkg-config
2017-11-29 12:25:44,249 [salt.state       ][INFO    ][21545] Package pkg-config is already installed
2017-11-29 12:25:44,249 [salt.state       ][INFO    ][21545] Completed state [pkg-config] at time 12:25:44.249149 duration_in_ms=4.128
2017-11-29 12:25:44,249 [salt.state       ][INFO    ][21545] Running state [virtng.init] at time 12:25:44.249351
2017-11-29 12:25:44,250 [salt.state       ][INFO    ][21545] Executing state module.run for virtng.init
2017-11-29 12:25:44,335 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command ['git', '--version'] in directory '/root'
2017-11-29 12:25:44,381 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:44,396 [salt.state       ][INFO    ][21545] unless execution succeeded
2017-11-29 12:25:44,396 [salt.state       ][INFO    ][21545] Completed state [virtng.init] at time 12:25:44.396104 duration_in_ms=146.743
2017-11-29 12:25:44,396 [salt.state       ][INFO    ][21545] Running state [virt.set_autostart] at time 12:25:44.396349
2017-11-29 12:25:44,397 [salt.state       ][INFO    ][21545] Executing state module.run for virt.set_autostart
2017-11-29 12:25:44,399 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:44,414 [salt.state       ][INFO    ][21545] unless execution succeeded
2017-11-29 12:25:44,414 [salt.state       ][INFO    ][21545] Completed state [virt.set_autostart] at time 12:25:44.413798 duration_in_ms=17.448
2017-11-29 12:25:44,414 [salt.state       ][INFO    ][21545] Running state [virtng.init] at time 12:25:44.414030
2017-11-29 12:25:44,414 [salt.state       ][INFO    ][21545] Executing state module.run for virtng.init
2017-11-29 12:25:44,417 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:44,432 [salt.state       ][INFO    ][21545] unless execution succeeded
2017-11-29 12:25:44,433 [salt.state       ][INFO    ][21545] Completed state [virtng.init] at time 12:25:44.432460 duration_in_ms=18.43
2017-11-29 12:25:44,433 [salt.state       ][INFO    ][21545] Running state [virt.set_autostart] at time 12:25:44.432731
2017-11-29 12:25:44,433 [salt.state       ][INFO    ][21545] Executing state module.run for virt.set_autostart
2017-11-29 12:25:44,436 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:44,451 [salt.state       ][INFO    ][21545] unless execution succeeded
2017-11-29 12:25:44,451 [salt.state       ][INFO    ][21545] Completed state [virt.set_autostart] at time 12:25:44.451456 duration_in_ms=18.725
2017-11-29 12:25:44,452 [salt.state       ][INFO    ][21545] Running state [virtng.init] at time 12:25:44.451679
2017-11-29 12:25:44,452 [salt.state       ][INFO    ][21545] Executing state module.run for virtng.init
2017-11-29 12:25:44,454 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:44,470 [salt.state       ][INFO    ][21545] unless execution succeeded
2017-11-29 12:25:44,470 [salt.state       ][INFO    ][21545] Completed state [virtng.init] at time 12:25:44.470100 duration_in_ms=18.42
2017-11-29 12:25:44,470 [salt.state       ][INFO    ][21545] Running state [virt.set_autostart] at time 12:25:44.470364
2017-11-29 12:25:44,471 [salt.state       ][INFO    ][21545] Executing state module.run for virt.set_autostart
2017-11-29 12:25:44,473 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:44,488 [salt.state       ][INFO    ][21545] unless execution succeeded
2017-11-29 12:25:44,488 [salt.state       ][INFO    ][21545] Completed state [virt.set_autostart] at time 12:25:44.488059 duration_in_ms=17.695
2017-11-29 12:25:44,488 [salt.state       ][INFO    ][21545] Running state [virtng.init] at time 12:25:44.488291
2017-11-29 12:25:44,488 [salt.state       ][INFO    ][21545] Executing state module.run for virtng.init
2017-11-29 12:25:44,491 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:44,507 [salt.state       ][INFO    ][21545] unless execution succeeded
2017-11-29 12:25:44,507 [salt.state       ][INFO    ][21545] Completed state [virtng.init] at time 12:25:44.507375 duration_in_ms=19.083
2017-11-29 12:25:44,508 [salt.state       ][INFO    ][21545] Running state [virt.set_autostart] at time 12:25:44.507648
2017-11-29 12:25:44,508 [salt.state       ][INFO    ][21545] Executing state module.run for virt.set_autostart
2017-11-29 12:25:44,511 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:44,525 [salt.state       ][INFO    ][21545] unless execution succeeded
2017-11-29 12:25:44,525 [salt.state       ][INFO    ][21545] Completed state [virt.set_autostart] at time 12:25:44.525433 duration_in_ms=17.784
2017-11-29 12:25:44,526 [salt.state       ][INFO    ][21545] Running state [virtng.init] at time 12:25:44.525658
2017-11-29 12:25:44,526 [salt.state       ][INFO    ][21545] Executing state module.run for virtng.init
2017-11-29 12:25:44,528 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:44,544 [salt.state       ][INFO    ][21545] unless execution succeeded
2017-11-29 12:25:44,544 [salt.state       ][INFO    ][21545] Completed state [virtng.init] at time 12:25:44.544360 duration_in_ms=18.702
2017-11-29 12:25:44,545 [salt.state       ][INFO    ][21545] Running state [virt.set_autostart] at time 12:25:44.544618
2017-11-29 12:25:44,545 [salt.state       ][INFO    ][21545] Executing state module.run for virt.set_autostart
2017-11-29 12:25:44,548 [salt.loaded.int.module.cmdmod][INFO    ][21545] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:44,562 [salt.state       ][INFO    ][21545] unless execution succeeded
2017-11-29 12:25:44,562 [salt.state       ][INFO    ][21545] Completed state [virt.set_autostart] at time 12:25:44.562322 duration_in_ms=17.703
2017-11-29 12:25:44,565 [salt.minion      ][INFO    ][21545] Returning information for job: 20171129122538764378
2017-11-29 12:25:46,004 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command pillar.get with jid 20171129122545995800
2017-11-29 12:25:46,016 [salt.minion      ][INFO    ][21640] Starting a new job with PID 21640
2017-11-29 12:25:46,019 [salt.minion      ][INFO    ][21640] Returning information for job: 20171129122545995800
2017-11-29 12:26:04,808 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171129122604803714
2017-11-29 12:26:04,822 [salt.minion      ][INFO    ][21647] Starting a new job with PID 21647
2017-11-29 12:26:09,501 [salt.state       ][INFO    ][21647] Loading fresh modules for state activity
2017-11-29 12:26:09,810 [salt.state       ][ERROR   ][21647] No contents found in top file
2017-11-29 12:26:09,811 [salt.utils.extmods][INFO    ][21647] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-29 12:26:09,815 [salt.utils.extmods][INFO    ][21647] Syncing beacons for environment 'base'
2017-11-29 12:26:09,815 [salt.utils.extmods][INFO    ][21647] Loading cache from salt://_beacons, for base)
2017-11-29 12:26:09,815 [salt.fileclient  ][INFO    ][21647] Caching directory '_beacons/' for environment 'base'
2017-11-29 12:26:09,873 [salt.utils.extmods][INFO    ][21647] Syncing modules for environment 'base'
2017-11-29 12:26:09,873 [salt.utils.extmods][INFO    ][21647] Loading cache from salt://_modules, for base)
2017-11-29 12:26:09,873 [salt.fileclient  ][INFO    ][21647] Caching directory '_modules/' for environment 'base'
2017-11-29 12:26:09,926 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-11-29 12:26:09,936 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-29 12:26:09,946 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-29 12:26:09,960 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-29 12:26:09,970 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-29 12:26:09,979 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-29 12:26:10,348 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-29 12:26:10,374 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-29 12:26:10,445 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-29 12:26:10,470 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-29 12:26:10,483 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-29 12:26:10,495 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-29 12:26:10,524 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-29 12:26:10,535 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-29 12:26:10,548 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-29 12:26:10,563 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-29 12:26:10,609 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-29 12:26:10,623 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-29 12:26:10,640 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-29 12:26:10,655 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-29 12:26:10,668 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-29 12:26:10,699 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-29 12:26:10,734 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-29 12:26:10,745 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-29 12:26:10,758 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-29 12:26:10,769 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-29 12:26:10,785 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-29 12:26:10,797 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-29 12:26:10,819 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-29 12:26:10,843 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-29 12:26:10,864 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-29 12:26:10,881 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-29 12:26:10,892 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-29 12:26:10,909 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-29 12:26:10,913 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-29 12:26:10,914 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-11-29 12:26:10,914 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-29 12:26:10,914 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-29 12:26:10,915 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-29 12:26:10,915 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-29 12:26:10,915 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-29 12:26:10,916 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-29 12:26:10,916 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-29 12:26:10,916 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-29 12:26:10,916 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-29 12:26:10,917 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-29 12:26:10,917 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-29 12:26:10,917 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-29 12:26:10,917 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-29 12:26:10,918 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-29 12:26:10,918 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-29 12:26:10,918 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-29 12:26:10,919 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-29 12:26:10,919 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-29 12:26:10,919 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-29 12:26:10,919 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-29 12:26:10,920 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-29 12:26:10,920 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-29 12:26:10,920 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-29 12:26:10,921 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-29 12:26:10,921 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-29 12:26:10,921 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-29 12:26:10,921 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-29 12:26:10,922 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-29 12:26:10,922 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-29 12:26:10,922 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-29 12:26:10,922 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-29 12:26:10,923 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-11-29 12:26:10,923 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-29 12:26:10,923 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-29 12:26:10,929 [salt.utils.extmods][INFO    ][21647] Syncing states for environment 'base'
2017-11-29 12:26:10,929 [salt.utils.extmods][INFO    ][21647] Loading cache from salt://_states, for base)
2017-11-29 12:26:10,929 [salt.fileclient  ][INFO    ][21647] Caching directory '_states/' for environment 'base'
2017-11-29 12:26:11,018 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-11-29 12:26:11,031 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-29 12:26:11,045 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-29 12:26:11,059 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-29 12:26:11,076 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-29 12:26:11,093 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-29 12:26:11,105 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-29 12:26:11,148 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-29 12:26:11,186 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-29 12:26:11,203 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-11-29 12:26:11,221 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-29 12:26:11,238 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-29 12:26:11,257 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-29 12:26:11,303 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-29 12:26:11,316 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-29 12:26:11,331 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-29 12:26:11,354 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-29 12:26:11,382 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-29 12:26:11,418 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-29 12:26:11,440 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-29 12:26:11,458 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-29 12:26:11,475 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-29 12:26:11,487 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-29 12:26:11,502 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-29 12:26:11,526 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-29 12:26:11,555 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-29 12:26:11,595 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-29 12:26:11,615 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-29 12:26:11,632 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-29 12:26:11,646 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-29 12:26:11,664 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-29 12:26:11,681 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-29 12:26:11,685 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-11-29 12:26:11,685 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-29 12:26:11,686 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-29 12:26:11,686 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-29 12:26:11,686 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-29 12:26:11,686 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-29 12:26:11,687 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-29 12:26:11,687 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-29 12:26:11,687 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-29 12:26:11,688 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-11-29 12:26:11,688 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-29 12:26:11,688 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-29 12:26:11,688 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-29 12:26:11,689 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-29 12:26:11,689 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-29 12:26:11,689 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-29 12:26:11,689 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-29 12:26:11,690 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-29 12:26:11,690 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-29 12:26:11,690 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-29 12:26:11,690 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-29 12:26:11,691 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-29 12:26:11,691 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-29 12:26:11,691 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-29 12:26:11,691 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-29 12:26:11,692 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-29 12:26:11,692 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-29 12:26:11,692 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-29 12:26:11,692 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-29 12:26:11,693 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-29 12:26:11,693 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-29 12:26:11,693 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-29 12:26:11,693 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-29 12:26:11,696 [salt.utils.extmods][INFO    ][21647] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-29 12:26:11,699 [salt.utils.extmods][INFO    ][21647] Syncing sdb for environment 'base'
2017-11-29 12:26:11,700 [salt.utils.extmods][INFO    ][21647] Loading cache from salt://_sdb, for base)
2017-11-29 12:26:11,700 [salt.fileclient  ][INFO    ][21647] Caching directory '_sdb/' for environment 'base'
2017-11-29 12:26:11,740 [salt.utils.extmods][INFO    ][21647] Syncing grains for environment 'base'
2017-11-29 12:26:11,740 [salt.utils.extmods][INFO    ][21647] Loading cache from salt://_grains, for base)
2017-11-29 12:26:11,741 [salt.fileclient  ][INFO    ][21647] Caching directory '_grains/' for environment 'base'
2017-11-29 12:26:11,830 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-29 12:26:11,849 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-29 12:26:11,880 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-29 12:26:11,890 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-29 12:26:11,902 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-29 12:26:11,917 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-29 12:26:11,930 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-29 12:26:11,942 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-29 12:26:11,953 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-29 12:26:11,965 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-29 12:26:11,974 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-29 12:26:11,989 [salt.fileclient  ][INFO    ][21647] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-29 12:26:11,994 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-29 12:26:11,994 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-29 12:26:11,994 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-29 12:26:11,994 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-29 12:26:11,995 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-29 12:26:11,995 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-29 12:26:11,995 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-29 12:26:11,995 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-29 12:26:11,996 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-29 12:26:11,996 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-29 12:26:11,996 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-29 12:26:11,996 [salt.utils.extmods][INFO    ][21647] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-29 12:26:11,998 [salt.utils.extmods][INFO    ][21647] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-29 12:26:12,001 [salt.utils.extmods][INFO    ][21647] Syncing renderers for environment 'base'
2017-11-29 12:26:12,001 [salt.utils.extmods][INFO    ][21647] Loading cache from salt://_renderers, for base)
2017-11-29 12:26:12,001 [salt.fileclient  ][INFO    ][21647] Caching directory '_renderers/' for environment 'base'
2017-11-29 12:26:12,073 [salt.utils.extmods][INFO    ][21647] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-29 12:26:12,075 [salt.utils.extmods][INFO    ][21647] Syncing returners for environment 'base'
2017-11-29 12:26:12,076 [salt.utils.extmods][INFO    ][21647] Loading cache from salt://_returners, for base)
2017-11-29 12:26:12,076 [salt.fileclient  ][INFO    ][21647] Caching directory '_returners/' for environment 'base'
2017-11-29 12:26:12,148 [salt.utils.extmods][INFO    ][21647] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-29 12:26:12,150 [salt.utils.extmods][INFO    ][21647] Syncing output for environment 'base'
2017-11-29 12:26:12,151 [salt.utils.extmods][INFO    ][21647] Loading cache from salt://_output, for base)
2017-11-29 12:26:12,151 [salt.fileclient  ][INFO    ][21647] Caching directory '_output/' for environment 'base'
2017-11-29 12:26:12,227 [salt.utils.extmods][INFO    ][21647] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-29 12:26:12,230 [salt.utils.extmods][INFO    ][21647] Syncing utils for environment 'base'
2017-11-29 12:26:12,230 [salt.utils.extmods][INFO    ][21647] Loading cache from salt://_utils, for base)
2017-11-29 12:26:12,230 [salt.fileclient  ][INFO    ][21647] Caching directory '_utils/' for environment 'base'
2017-11-29 12:26:12,278 [salt.utils.extmods][INFO    ][21647] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-29 12:26:12,281 [salt.utils.extmods][INFO    ][21647] Syncing log_handlers for environment 'base'
2017-11-29 12:26:12,281 [salt.utils.extmods][INFO    ][21647] Loading cache from salt://_log_handlers, for base)
2017-11-29 12:26:12,281 [salt.fileclient  ][INFO    ][21647] Caching directory '_log_handlers/' for environment 'base'
2017-11-29 12:26:12,329 [salt.utils.extmods][INFO    ][21647] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-29 12:26:12,332 [salt.utils.extmods][INFO    ][21647] Syncing proxy for environment 'base'
2017-11-29 12:26:12,332 [salt.utils.extmods][INFO    ][21647] Loading cache from salt://_proxy, for base)
2017-11-29 12:26:12,332 [salt.fileclient  ][INFO    ][21647] Caching directory '_proxy/' for environment 'base'
2017-11-29 12:26:12,380 [salt.utils.extmods][INFO    ][21647] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-29 12:26:12,383 [salt.utils.extmods][INFO    ][21647] Syncing engines for environment 'base'
2017-11-29 12:26:12,383 [salt.utils.extmods][INFO    ][21647] Loading cache from salt://_engines, for base)
2017-11-29 12:26:12,383 [salt.fileclient  ][INFO    ][21647] Caching directory '_engines/' for environment 'base'
2017-11-29 12:26:12,476 [salt.minion      ][INFO    ][21647] Returning information for job: 20171129122604803714
2017-11-29 12:32:20,970 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command test.ping with jid 20171129123220963054
2017-11-29 12:32:20,984 [salt.minion      ][INFO    ][21821] Starting a new job with PID 21821
2017-11-29 12:32:21,024 [salt.minion      ][INFO    ][21821] Returning information for job: 20171129123220963054
2017-11-29 12:33:56,670 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command state.sls with jid 20171129123356662605
2017-11-29 12:33:56,684 [salt.minion      ][INFO    ][21858] Starting a new job with PID 21858
2017-11-29 12:33:57,251 [salt.state       ][INFO    ][21858] Loading fresh modules for state activity
2017-11-29 12:33:57,282 [salt.fileclient  ][INFO    ][21858] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-29 12:33:57,301 [salt.fileclient  ][INFO    ][21858] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-29 12:33:57,329 [salt.fileclient  ][INFO    ][21858] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 12:33:57,680 [salt.state       ][INFO    ][21858] Running state [lsof] at time 12:33:57.679792
2017-11-29 12:33:57,680 [salt.state       ][INFO    ][21858] Executing state pkg.installed for lsof
2017-11-29 12:33:57,681 [salt.loaded.int.module.cmdmod][INFO    ][21858] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:33:57,974 [salt.state       ][INFO    ][21858] Package lsof is already installed
2017-11-29 12:33:57,975 [salt.state       ][INFO    ][21858] Completed state [lsof] at time 12:33:57.974652 duration_in_ms=294.86
2017-11-29 12:33:57,975 [salt.state       ][INFO    ][21858] Running state [keepalived] at time 12:33:57.974938
2017-11-29 12:33:57,975 [salt.state       ][INFO    ][21858] Executing state pkg.installed for keepalived
2017-11-29 12:33:57,992 [salt.loaded.int.module.cmdmod][INFO    ][21858] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-29 12:33:59,252 [salt.loaded.int.module.cmdmod][INFO    ][21858] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-11-29 12:34:01,879 [salt.loaded.int.module.cmdmod][INFO    ][21858] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:34:01,908 [salt.state       ][INFO    ][21858] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-11-29 12:34:01,919 [salt.state       ][INFO    ][21858] Loading fresh modules for state activity
2017-11-29 12:34:01,935 [salt.state       ][INFO    ][21858] Completed state [keepalived] at time 12:34:01.934818 duration_in_ms=3959.879
2017-11-29 12:34:01,937 [salt.state       ][INFO    ][21858] Running state [/etc/keepalived/keepalived.conf] at time 12:34:01.936888
2017-11-29 12:34:01,937 [salt.state       ][INFO    ][21858] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-29 12:34:01,969 [salt.fileclient  ][INFO    ][21858] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-29 12:34:02,010 [salt.fileclient  ][INFO    ][21858] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 12:34:02,018 [salt.state       ][INFO    ][21858] File changed:
New file
2017-11-29 12:34:02,018 [salt.state       ][INFO    ][21858] Completed state [/etc/keepalived/keepalived.conf] at time 12:34:02.017981 duration_in_ms=81.093
2017-11-29 12:34:02,086 [salt.state       ][INFO    ][21858] Running state [keepalived] at time 12:34:02.086298
2017-11-29 12:34:02,087 [salt.state       ][INFO    ][21858] Executing state service.running for keepalived
2017-11-29 12:34:02,088 [salt.loaded.int.module.cmdmod][INFO    ][21858] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-29 12:34:02,098 [salt.loaded.int.module.cmdmod][INFO    ][21858] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-29 12:34:02,106 [salt.loaded.int.module.cmdmod][INFO    ][21858] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-29 12:34:02,114 [salt.loaded.int.module.cmdmod][INFO    ][21858] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-29 12:34:02,123 [salt.loaded.int.module.cmdmod][INFO    ][21858] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-29 12:34:02,155 [salt.loaded.int.module.cmdmod][INFO    ][21858] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-29 12:34:02,164 [salt.loaded.int.module.cmdmod][INFO    ][21858] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-29 12:34:02,171 [salt.loaded.int.module.cmdmod][INFO    ][21858] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-29 12:34:02,177 [salt.state       ][INFO    ][21858] {'keepalived': True}
2017-11-29 12:34:02,178 [salt.state       ][INFO    ][21858] Completed state [keepalived] at time 12:34:02.177675 duration_in_ms=91.377
2017-11-29 12:34:02,179 [salt.minion      ][INFO    ][21858] Returning information for job: 20171129123356662605
2017-11-29 12:34:10,982 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command pillar.get with jid 20171129123410972280
2017-11-29 12:34:10,997 [salt.minion      ][INFO    ][23274] Starting a new job with PID 23274
2017-11-29 12:34:11,003 [salt.minion      ][INFO    ][23274] Returning information for job: 20171129123410972280
2017-11-29 12:39:03,551 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command state.sls with jid 20171129123903542564
2017-11-29 12:39:03,563 [salt.minion      ][INFO    ][23366] Starting a new job with PID 23366
2017-11-29 12:39:05,872 [salt.state       ][INFO    ][23366] Loading fresh modules for state activity
2017-11-29 12:39:05,903 [salt.fileclient  ][INFO    ][23366] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-29 12:39:05,926 [salt.fileclient  ][INFO    ][23366] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-29 12:39:06,225 [salt.state       ][INFO    ][23366] Running state [attr] at time 12:39:06.225143
2017-11-29 12:39:06,225 [salt.state       ][INFO    ][23366] Executing state pkg.installed for attr
2017-11-29 12:39:06,226 [salt.loaded.int.module.cmdmod][INFO    ][23366] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:39:06,505 [salt.loaded.int.module.cmdmod][INFO    ][23366] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-29 12:39:07,775 [salt.loaded.int.module.cmdmod][INFO    ][23366] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-11-29 12:39:09,121 [salt.loaded.int.module.cmdmod][INFO    ][23366] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:39:09,149 [salt.state       ][INFO    ][23366] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-29 12:39:09,159 [salt.state       ][INFO    ][23366] Loading fresh modules for state activity
2017-11-29 12:39:09,176 [salt.state       ][INFO    ][23366] Completed state [attr] at time 12:39:09.175675 duration_in_ms=2950.532
2017-11-29 12:39:09,181 [salt.state       ][INFO    ][23366] Running state [glusterfs-server] at time 12:39:09.181031
2017-11-29 12:39:09,181 [salt.state       ][INFO    ][23366] Executing state pkg.installed for glusterfs-server
2017-11-29 12:39:09,399 [salt.loaded.int.module.cmdmod][INFO    ][23366] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-11-29 12:39:13,667 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command saltutil.find_job with jid 20171129123913647448
2017-11-29 12:39:13,678 [salt.minion      ][INFO    ][25524] Starting a new job with PID 25524
2017-11-29 12:39:13,690 [salt.minion      ][INFO    ][25524] Returning information for job: 20171129123913647448
2017-11-29 12:39:14,900 [salt.loaded.int.module.cmdmod][INFO    ][23366] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:39:14,929 [salt.state       ][INFO    ][23366] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'glusterfs-client' changed from 'absent' to '3.10.7-ubuntu1~xenial1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.2'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'glusterfs-common' changed from 'absent' to '3.10.7-ubuntu1~xenial1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'portmap' changed from 'absent' to '1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'
'nfs-client' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.10.7-ubuntu1~xenial1'

2017-11-29 12:39:14,939 [salt.state       ][INFO    ][23366] Loading fresh modules for state activity
2017-11-29 12:39:14,957 [salt.state       ][INFO    ][23366] Completed state [glusterfs-server] at time 12:39:14.956606 duration_in_ms=5775.575
2017-11-29 12:39:14,962 [salt.state       ][INFO    ][23366] Running state [bc] at time 12:39:14.961472
2017-11-29 12:39:14,962 [salt.state       ][INFO    ][23366] Executing state pkg.installed for bc
2017-11-29 12:39:15,244 [salt.loaded.int.module.cmdmod][INFO    ][23366] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-11-29 12:39:16,670 [salt.loaded.int.module.cmdmod][INFO    ][23366] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:39:16,702 [salt.state       ][INFO    ][23366] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-29 12:39:16,715 [salt.state       ][INFO    ][23366] Loading fresh modules for state activity
2017-11-29 12:39:16,733 [salt.state       ][INFO    ][23366] Completed state [bc] at time 12:39:16.732533 duration_in_ms=1771.061
2017-11-29 12:39:16,808 [salt.state       ][INFO    ][23366] Running state [glusterfs-server] at time 12:39:16.807829
2017-11-29 12:39:16,808 [salt.state       ][INFO    ][23366] Executing state service.running for glusterfs-server
2017-11-29 12:39:16,810 [salt.loaded.int.module.cmdmod][INFO    ][23366] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-29 12:39:16,819 [salt.loaded.int.module.cmdmod][INFO    ][23366] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-29 12:39:16,828 [salt.loaded.int.module.cmdmod][INFO    ][23366] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-29 12:39:16,836 [salt.state       ][INFO    ][23366] The service glusterfs-server is already running
2017-11-29 12:39:16,836 [salt.state       ][INFO    ][23366] Completed state [glusterfs-server] at time 12:39:16.836417 duration_in_ms=28.588
2017-11-29 12:39:16,838 [salt.state       ][INFO    ][23366] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:39:16.838225
2017-11-29 12:39:16,839 [salt.state       ][INFO    ][23366] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-29 12:39:16,844 [salt.state       ][INFO    ][23366] File changed:
New file
2017-11-29 12:39:16,844 [salt.state       ][INFO    ][23366] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:39:16.843909 duration_in_ms=5.684
2017-11-29 12:39:16,844 [salt.state       ][INFO    ][23366] Running state [/srv/glusterfs/glance] at time 12:39:16.844107
2017-11-29 12:39:16,844 [salt.state       ][INFO    ][23366] Executing state file.directory for /srv/glusterfs/glance
2017-11-29 12:39:16,845 [salt.state       ][INFO    ][23366] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-29 12:39:16,845 [salt.state       ][INFO    ][23366] Completed state [/srv/glusterfs/glance] at time 12:39:16.845156 duration_in_ms=1.049
2017-11-29 12:39:16,845 [salt.state       ][INFO    ][23366] Running state [/srv/glusterfs/keystone-keys] at time 12:39:16.845352
2017-11-29 12:39:16,846 [salt.state       ][INFO    ][23366] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-29 12:39:16,846 [salt.state       ][INFO    ][23366] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-29 12:39:16,846 [salt.state       ][INFO    ][23366] Completed state [/srv/glusterfs/keystone-keys] at time 12:39:16.846146 duration_in_ms=0.794
2017-11-29 12:39:16,846 [salt.state       ][INFO    ][23366] Running state [/srv/glusterfs/nova_instances] at time 12:39:16.846323
2017-11-29 12:39:16,847 [salt.state       ][INFO    ][23366] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-29 12:39:16,847 [salt.state       ][INFO    ][23366] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-29 12:39:16,847 [salt.state       ][INFO    ][23366] Completed state [/srv/glusterfs/nova_instances] at time 12:39:16.847116 duration_in_ms=0.793
2017-11-29 12:39:16,847 [salt.state       ][INFO    ][23366] Running state [/srv/glusterfs/keystone-credential-keys] at time 12:39:16.847292
2017-11-29 12:39:16,847 [salt.state       ][INFO    ][23366] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-29 12:39:16,848 [salt.state       ][INFO    ][23366] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-29 12:39:16,848 [salt.state       ][INFO    ][23366] Completed state [/srv/glusterfs/keystone-credential-keys] at time 12:39:16.848075 duration_in_ms=0.784
2017-11-29 12:39:16,849 [salt.minion      ][INFO    ][23366] Returning information for job: 20171129123903542564
2017-11-29 12:39:20,296 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command test.ping with jid 20171129123920286536
2017-11-29 12:39:20,307 [salt.minion      ][INFO    ][26154] Starting a new job with PID 26154
2017-11-29 12:39:20,342 [salt.minion      ][INFO    ][26154] Returning information for job: 20171129123920286536
2017-11-29 12:39:45,524 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command state.sls with jid 20171129123945513511
2017-11-29 12:39:45,536 [salt.minion      ][INFO    ][26787] Starting a new job with PID 26787
2017-11-29 12:39:46,164 [salt.state       ][INFO    ][26787] Loading fresh modules for state activity
2017-11-29 12:39:46,194 [salt.fileclient  ][INFO    ][26787] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-29 12:39:46,231 [salt.fileclient  ][INFO    ][26787] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-29 12:39:46,319 [salt.fileclient  ][INFO    ][26787] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-29 12:39:46,341 [salt.fileclient  ][INFO    ][26787] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-29 12:39:46,653 [salt.state       ][INFO    ][26787] Running state [attr] at time 12:39:46.653238
2017-11-29 12:39:46,654 [salt.state       ][INFO    ][26787] Executing state pkg.installed for attr
2017-11-29 12:39:46,654 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:39:46,921 [salt.state       ][INFO    ][26787] Package attr is already installed
2017-11-29 12:39:46,922 [salt.state       ][INFO    ][26787] Completed state [attr] at time 12:39:46.921701 duration_in_ms=268.463
2017-11-29 12:39:46,922 [salt.state       ][INFO    ][26787] Running state [glusterfs-server] at time 12:39:46.921966
2017-11-29 12:39:46,922 [salt.state       ][INFO    ][26787] Executing state pkg.installed for glusterfs-server
2017-11-29 12:39:46,926 [salt.state       ][INFO    ][26787] Package glusterfs-server is already installed
2017-11-29 12:39:46,926 [salt.state       ][INFO    ][26787] Completed state [glusterfs-server] at time 12:39:46.925956 duration_in_ms=3.99
2017-11-29 12:39:46,926 [salt.state       ][INFO    ][26787] Running state [bc] at time 12:39:46.926148
2017-11-29 12:39:46,926 [salt.state       ][INFO    ][26787] Executing state pkg.installed for bc
2017-11-29 12:39:46,930 [salt.state       ][INFO    ][26787] Package bc is already installed
2017-11-29 12:39:46,930 [salt.state       ][INFO    ][26787] Completed state [bc] at time 12:39:46.929998 duration_in_ms=3.849
2017-11-29 12:39:46,931 [salt.state       ][INFO    ][26787] Running state [glusterfs-server] at time 12:39:46.931065
2017-11-29 12:39:46,931 [salt.state       ][INFO    ][26787] Executing state service.running for glusterfs-server
2017-11-29 12:39:46,932 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-29 12:39:46,941 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-29 12:39:46,988 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-29 12:39:47,001 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-29 12:39:47,007 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-29 12:39:47,015 [salt.state       ][INFO    ][26787] The service glusterfs-server is already running
2017-11-29 12:39:47,015 [salt.state       ][INFO    ][26787] Completed state [glusterfs-server] at time 12:39:47.014912 duration_in_ms=83.847
2017-11-29 12:39:47,016 [salt.state       ][INFO    ][26787] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:39:47.016394
2017-11-29 12:39:47,017 [salt.state       ][INFO    ][26787] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-29 12:39:47,019 [salt.state       ][INFO    ][26787] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-29 12:39:47,019 [salt.state       ][INFO    ][26787] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:39:47.018772 duration_in_ms=2.377
2017-11-29 12:39:47,019 [salt.state       ][INFO    ][26787] Running state [/srv/glusterfs/glance] at time 12:39:47.018973
2017-11-29 12:39:47,019 [salt.state       ][INFO    ][26787] Executing state file.directory for /srv/glusterfs/glance
2017-11-29 12:39:47,020 [salt.state       ][INFO    ][26787] Directory /srv/glusterfs/glance is in the correct state
2017-11-29 12:39:47,020 [salt.state       ][INFO    ][26787] Completed state [/srv/glusterfs/glance] at time 12:39:47.019752 duration_in_ms=0.778
2017-11-29 12:39:47,020 [salt.state       ][INFO    ][26787] Running state [/srv/glusterfs/keystone-keys] at time 12:39:47.019940
2017-11-29 12:39:47,020 [salt.state       ][INFO    ][26787] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-29 12:39:47,021 [salt.state       ][INFO    ][26787] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-29 12:39:47,021 [salt.state       ][INFO    ][26787] Completed state [/srv/glusterfs/keystone-keys] at time 12:39:47.020687 duration_in_ms=0.746
2017-11-29 12:39:47,021 [salt.state       ][INFO    ][26787] Running state [/srv/glusterfs/nova_instances] at time 12:39:47.020859
2017-11-29 12:39:47,021 [salt.state       ][INFO    ][26787] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-29 12:39:47,022 [salt.state       ][INFO    ][26787] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-29 12:39:47,022 [salt.state       ][INFO    ][26787] Completed state [/srv/glusterfs/nova_instances] at time 12:39:47.021652 duration_in_ms=0.792
2017-11-29 12:39:47,022 [salt.state       ][INFO    ][26787] Running state [/srv/glusterfs/keystone-credential-keys] at time 12:39:47.021827
2017-11-29 12:39:47,022 [salt.state       ][INFO    ][26787] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-29 12:39:47,022 [salt.state       ][INFO    ][26787] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-29 12:39:47,023 [salt.state       ][INFO    ][26787] Completed state [/srv/glusterfs/keystone-credential-keys] at time 12:39:47.022539 duration_in_ms=0.713
2017-11-29 12:39:47,084 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command ['git', '--version'] in directory '/root'
2017-11-29 12:39:47,171 [salt.state       ][INFO    ][26787] Running state [sleep 5] at time 12:39:47.170654
2017-11-29 12:39:47,171 [salt.state       ][INFO    ][26787] Executing state cmd.wait for sleep 5
2017-11-29 12:39:47,171 [salt.state       ][INFO    ][26787] No changes made for sleep 5
2017-11-29 12:39:47,171 [salt.state       ][INFO    ][26787] Completed state [sleep 5] at time 12:39:47.171392 duration_in_ms=0.738
2017-11-29 12:39:47,172 [salt.state       ][INFO    ][26787] Running state [192.168.10.143] at time 12:39:47.171993
2017-11-29 12:39:47,172 [salt.state       ][INFO    ][26787] Executing state glusterfs.peered for 192.168.10.143
2017-11-29 12:39:47,173 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:47,181 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:47,236 [salt.state       ][INFO    ][26787] Host 192.168.10.143 already peered
2017-11-29 12:39:47,236 [salt.state       ][INFO    ][26787] Completed state [192.168.10.143] at time 12:39:47.236055 duration_in_ms=64.061
2017-11-29 12:39:47,239 [salt.state       ][INFO    ][26787] Running state [192.168.10.142] at time 12:39:47.239071
2017-11-29 12:39:47,239 [salt.state       ][INFO    ][26787] Executing state glusterfs.peered for 192.168.10.142
2017-11-29 12:39:47,240 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:47,248 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:47,305 [salt.state       ][INFO    ][26787] Host 192.168.10.142 already peered
2017-11-29 12:39:47,305 [salt.state       ][INFO    ][26787] Completed state [192.168.10.142] at time 12:39:47.305108 duration_in_ms=66.037
2017-11-29 12:39:47,308 [salt.state       ][INFO    ][26787] Running state [192.168.10.141] at time 12:39:47.308125
2017-11-29 12:39:47,308 [salt.state       ][INFO    ][26787] Executing state glusterfs.peered for 192.168.10.141
2017-11-29 12:39:47,309 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:47,317 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:47,373 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:47,380 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:47,435 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:47,443 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:47,498 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:47,506 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:47,562 [salt.state       ][INFO    ][26787] Peering with localhost is not needed
2017-11-29 12:39:47,562 [salt.state       ][INFO    ][26787] Completed state [192.168.10.141] at time 12:39:47.562344 duration_in_ms=254.218
2017-11-29 12:39:47,563 [salt.state       ][INFO    ][26787] Running state [glance] at time 12:39:47.563431
2017-11-29 12:39:47,564 [salt.state       ][INFO    ][26787] Executing state glusterfs.created for glance
2017-11-29 12:39:47,564 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:47,572 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:47,626 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:47,634 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:47,692 [salt.state       ][INFO    ][26787] Volume glance already exists and is started.
2017-11-29 12:39:47,693 [salt.state       ][INFO    ][26787] Completed state [glance] at time 12:39:47.692574 duration_in_ms=129.142
2017-11-29 12:39:47,697 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:47.696848
2017-11-29 12:39:47,697 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-29 12:39:47,698 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:47,754 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:47,754 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:47.754017 duration_in_ms=57.169
2017-11-29 12:39:47,755 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 12:39:47.754646
2017-11-29 12:39:47,755 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-29 12:39:47,755 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-29 12:39:47,811 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:47,811 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 12:39:47.811328 duration_in_ms=56.681
2017-11-29 12:39:47,812 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 12:39:47.811902
2017-11-29 12:39:47,812 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-29 12:39:47,813 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-29 12:39:47,867 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:47,867 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 12:39:47.866993 duration_in_ms=55.091
2017-11-29 12:39:47,868 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:47.867603
2017-11-29 12:39:47,868 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-11-29 12:39:47,868 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-29 12:39:47,922 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:47,922 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:47.921849 duration_in_ms=54.245
2017-11-29 12:39:47,922 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:47.922418
2017-11-29 12:39:47,923 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-29 12:39:47,923 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:47,976 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:47,976 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:47.976087 duration_in_ms=53.668
2017-11-29 12:39:47,977 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 12:39:47.976673
2017-11-29 12:39:47,977 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-29 12:39:47,977 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-29 12:39:48,034 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:48,034 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 12:39:48.034031 duration_in_ms=57.358
2017-11-29 12:39:48,036 [salt.state       ][INFO    ][26787] Running state [glance] at time 12:39:48.035621
2017-11-29 12:39:48,036 [salt.state       ][INFO    ][26787] Executing state glusterfs.started for glance
2017-11-29 12:39:48,036 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:48,045 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:48,100 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:48,108 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:48,168 [salt.state       ][INFO    ][26787] Volume glance is already started
2017-11-29 12:39:48,168 [salt.state       ][INFO    ][26787] Completed state [glance] at time 12:39:48.168007 duration_in_ms=132.386
2017-11-29 12:39:48,170 [salt.state       ][INFO    ][26787] Running state [keystone-keys] at time 12:39:48.169796
2017-11-29 12:39:48,170 [salt.state       ][INFO    ][26787] Executing state glusterfs.created for keystone-keys
2017-11-29 12:39:48,171 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:48,180 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:48,236 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:48,245 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:48,304 [salt.state       ][INFO    ][26787] Volume keystone-keys already exists and is started.
2017-11-29 12:39:48,304 [salt.state       ][INFO    ][26787] Completed state [keystone-keys] at time 12:39:48.303905 duration_in_ms=134.109
2017-11-29 12:39:48,309 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 12:39:48.308618
2017-11-29 12:39:48,309 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-29 12:39:48,311 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-29 12:39:48,368 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:48,368 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 12:39:48.367926 duration_in_ms=59.308
2017-11-29 12:39:48,369 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:48.369331
2017-11-29 12:39:48,370 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-29 12:39:48,370 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:48,426 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:48,426 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:48.426353 duration_in_ms=57.022
2017-11-29 12:39:48,427 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:48.426972
2017-11-29 12:39:48,427 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-29 12:39:48,428 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-29 12:39:48,483 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:48,483 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:48.483199 duration_in_ms=56.227
2017-11-29 12:39:48,484 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:48.483775
2017-11-29 12:39:48,484 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-29 12:39:48,485 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:48,542 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:48,542 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:48.542407 duration_in_ms=58.631
2017-11-29 12:39:48,543 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 12:39:48.543052
2017-11-29 12:39:48,543 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-29 12:39:48,544 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-29 12:39:48,600 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:48,601 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 12:39:48.600556 duration_in_ms=57.504
2017-11-29 12:39:48,601 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 12:39:48.601295
2017-11-29 12:39:48,602 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-29 12:39:48,602 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-29 12:39:48,659 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:48,660 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 12:39:48.659961 duration_in_ms=58.664
2017-11-29 12:39:48,663 [salt.state       ][INFO    ][26787] Running state [keystone-keys] at time 12:39:48.663401
2017-11-29 12:39:48,664 [salt.state       ][INFO    ][26787] Executing state glusterfs.started for keystone-keys
2017-11-29 12:39:48,665 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:48,673 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:48,730 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:48,739 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:48,807 [salt.state       ][INFO    ][26787] Volume keystone-keys is already started
2017-11-29 12:39:48,808 [salt.state       ][INFO    ][26787] Completed state [keystone-keys] at time 12:39:48.807490 duration_in_ms=144.091
2017-11-29 12:39:48,809 [salt.state       ][INFO    ][26787] Running state [nova_instances] at time 12:39:48.808687
2017-11-29 12:39:48,809 [salt.state       ][INFO    ][26787] Executing state glusterfs.created for nova_instances
2017-11-29 12:39:48,809 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:48,818 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:48,874 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:48,881 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:48,940 [salt.state       ][INFO    ][26787] Volume nova_instances already exists and is started.
2017-11-29 12:39:48,941 [salt.state       ][INFO    ][26787] Completed state [nova_instances] at time 12:39:48.940711 duration_in_ms=132.024
2017-11-29 12:39:48,946 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:48.945636
2017-11-29 12:39:48,946 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-29 12:39:48,946 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:49,001 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:49,001 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:49.000992 duration_in_ms=55.355
2017-11-29 12:39:49,002 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 12:39:49.001619
2017-11-29 12:39:49,002 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-11-29 12:39:49,002 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-29 12:39:49,059 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:49,059 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 12:39:49.058758 duration_in_ms=57.139
2017-11-29 12:39:49,059 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 12:39:49.059397
2017-11-29 12:39:49,060 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-11-29 12:39:49,060 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-29 12:39:49,114 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:49,114 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 12:39:49.113713 duration_in_ms=54.316
2017-11-29 12:39:49,114 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:49.114312
2017-11-29 12:39:49,115 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-11-29 12:39:49,115 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-29 12:39:49,168 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:49,168 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:49.168001 duration_in_ms=53.689
2017-11-29 12:39:49,169 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 12:39:49.168606
2017-11-29 12:39:49,169 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-11-29 12:39:49,169 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-11-29 12:39:49,226 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:49,226 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 12:39:49.225858 duration_in_ms=57.251
2017-11-29 12:39:49,227 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:49.226602
2017-11-29 12:39:49,227 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-29 12:39:49,227 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:49,285 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:49,286 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:49.285660 duration_in_ms=59.058
2017-11-29 12:39:49,287 [salt.state       ][INFO    ][26787] Running state [nova_instances] at time 12:39:49.287180
2017-11-29 12:39:49,287 [salt.state       ][INFO    ][26787] Executing state glusterfs.started for nova_instances
2017-11-29 12:39:49,288 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:49,296 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:49,352 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:49,361 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:49,420 [salt.state       ][INFO    ][26787] Volume nova_instances is already started
2017-11-29 12:39:49,420 [salt.state       ][INFO    ][26787] Completed state [nova_instances] at time 12:39:49.420035 duration_in_ms=132.854
2017-11-29 12:39:49,421 [salt.state       ][INFO    ][26787] Running state [keystone-credential-keys] at time 12:39:49.421263
2017-11-29 12:39:49,422 [salt.state       ][INFO    ][26787] Executing state glusterfs.created for keystone-credential-keys
2017-11-29 12:39:49,422 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:49,430 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:49,486 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:49,494 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:49,553 [salt.state       ][INFO    ][26787] Volume keystone-credential-keys already exists and is started.
2017-11-29 12:39:49,553 [salt.state       ][INFO    ][26787] Completed state [keystone-credential-keys] at time 12:39:49.553073 duration_in_ms=131.81
2017-11-29 12:39:49,558 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 12:39:49.558147
2017-11-29 12:39:49,558 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-29 12:39:49,559 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-29 12:39:49,615 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:49,615 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 12:39:49.614987 duration_in_ms=56.839
2017-11-29 12:39:49,616 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:49.615655
2017-11-29 12:39:49,616 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-29 12:39:49,616 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-29 12:39:49,673 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:49,673 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:49.673376 duration_in_ms=57.721
2017-11-29 12:39:49,674 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:49.674026
2017-11-29 12:39:49,674 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-29 12:39:49,675 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:49,729 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:49,729 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:49.729093 duration_in_ms=55.067
2017-11-29 12:39:49,730 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 12:39:49.729707
2017-11-29 12:39:49,730 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-29 12:39:49,730 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-29 12:39:49,786 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:49,786 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 12:39:49.786430 duration_in_ms=56.722
2017-11-29 12:39:49,787 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:49.787040
2017-11-29 12:39:49,787 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-29 12:39:49,788 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:49,845 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:49,845 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:49.845043 duration_in_ms=58.002
2017-11-29 12:39:49,846 [salt.state       ][INFO    ][26787] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 12:39:49.845717
2017-11-29 12:39:49,846 [salt.state       ][INFO    ][26787] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-29 12:39:49,847 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-29 12:39:49,901 [salt.state       ][INFO    ][26787] unless execution succeeded
2017-11-29 12:39:49,902 [salt.state       ][INFO    ][26787] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 12:39:49.901470 duration_in_ms=55.752
2017-11-29 12:39:49,903 [salt.state       ][INFO    ][26787] Running state [keystone-credential-keys] at time 12:39:49.902992
2017-11-29 12:39:49,903 [salt.state       ][INFO    ][26787] Executing state glusterfs.started for keystone-credential-keys
2017-11-29 12:39:49,904 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:49,912 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:49,967 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:49,976 [salt.loaded.int.module.cmdmod][INFO    ][26787] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:50,034 [salt.state       ][INFO    ][26787] Volume keystone-credential-keys is already started
2017-11-29 12:39:50,035 [salt.state       ][INFO    ][26787] Completed state [keystone-credential-keys] at time 12:39:50.034506 duration_in_ms=131.501
2017-11-29 12:39:50,037 [salt.minion      ][INFO    ][26787] Returning information for job: 20171129123945513511
2017-11-29 12:39:51,055 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command test.ping with jid 20171129123951047011
2017-11-29 12:39:51,067 [salt.minion      ][INFO    ][27314] Starting a new job with PID 27314
2017-11-29 12:39:51,101 [salt.minion      ][INFO    ][27314] Returning information for job: 20171129123951047011
2017-11-29 12:39:51,751 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command cmd.run with jid 20171129123951742046
2017-11-29 12:39:51,761 [salt.minion      ][INFO    ][27319] Starting a new job with PID 27319
2017-11-29 12:39:51,765 [salt.loaded.int.module.cmdmod][INFO    ][27319] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-29 12:39:51,882 [salt.minion      ][INFO    ][27319] Returning information for job: 20171129123951742046
2017-11-29 13:24:48,698 [salt.utils.schedule][INFO    ][21243] Running scheduled job: __mine_interval
2017-11-29 13:38:16,882 [salt.minion      ][INFO    ][21243] User sudo_ubuntu Executing command cp.push_dir with jid 20171129133816869944
2017-11-29 13:38:16,901 [salt.minion      ][INFO    ][28007] Starting a new job with PID 28007
