2017-12-19 21:10:24,549 [salt.cli.daemons ][WARNING ][2437] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-19 21:10:34,428 [salt.state       ][ERROR   ][3668] No contents found in top file
2017-12-19 21:13:58,003 [salt.utils.parsers][WARNING ][2437] Minion received a SIGTERM. Exiting.
2017-12-19 21:16:12,099 [salt.cli.daemons ][WARNING ][3160] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-19 21:17:54,587 [salt.transport.ipc][ERROR   ][3160] Exception occurred while handling stream: [Errno 0] Success
2017-12-19 21:19:22,196 [py.warnings      ][WARNING ][14075] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-12-19 21:22:20,314 [salt.loaded.int.module.cmdmod][ERROR   ][14075] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-19 21:22:20,315 [salt.loaded.int.module.cmdmod][ERROR   ][14075] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-19 21:22:26,412 [salt.loaded.int.module.cmdmod][ERROR   ][14075] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-19 21:22:26,413 [salt.loaded.int.module.cmdmod][ERROR   ][14075] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-19 21:22:34,059 [salt.loaded.int.module.cmdmod][ERROR   ][14075] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-19 21:22:34,060 [salt.loaded.int.module.cmdmod][ERROR   ][14075] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-19 21:22:42,872 [salt.loaded.int.module.cmdmod][ERROR   ][14075] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-19 21:22:42,872 [salt.loaded.int.module.cmdmod][ERROR   ][14075] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-19 21:22:48,743 [salt.loaded.int.module.cmdmod][ERROR   ][14075] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-12-19 21:22:50,882 [salt.loaded.int.module.cmdmod][INFO    ][21261] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-19 21:22:50,889 [salt.loaded.int.module.cmdmod][INFO    ][21261] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-19 21:22:50,899 [salt.loaded.int.module.cmdmod][INFO    ][21261] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-19 21:22:50,908 [salt.utils.parsers][WARNING ][3160] Minion received a SIGTERM. Exiting.
2017-12-19 21:22:51,161 [salt.cli.daemons ][INFO    ][21335] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-12-19 21:22:51,684 [salt.minion      ][INFO    ][21335] Creating minion process manager
2017-12-19 21:22:51,685 [salt.cli.daemons ][WARNING ][21335] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-19 21:22:51,685 [salt.cli.daemons ][INFO    ][21335] The Salt Minion is starting up
2017-12-19 21:22:51,685 [salt.minion      ][INFO    ][21335] Minion is starting as user 'root'
2017-12-19 21:22:51,685 [salt.utils.event ][INFO    ][21335] Starting pull socket on /var/run/salt/minion/minion_event_0031115955_pull.ipc
2017-12-19 21:22:52,585 [salt.loaded.int.module.cmdmod][INFO    ][21335] Executing command ['date', '+%z'] in directory '/root'
2017-12-19 21:22:52,593 [salt.utils.schedule][INFO    ][21335] Updating job settings for scheduled job: __mine_interval
2017-12-19 21:22:52,595 [salt.minion      ][INFO    ][21335] Added mine.update to scheduler
2017-12-19 21:22:52,644 [salt.minion      ][INFO    ][21335] Minion is ready to receive requests!
2017-12-19 21:22:53,645 [salt.utils.schedule][INFO    ][21335] Running scheduled job: __mine_interval
2017-12-19 21:23:06,992 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171219212306976775
2017-12-19 21:23:07,006 [salt.minion      ][INFO    ][21447] Starting a new job with PID 21447
2017-12-19 21:23:09,434 [salt.state       ][INFO    ][21447] Loading fresh modules for state activity
2017-12-19 21:23:09,456 [salt.state       ][ERROR   ][21447] No contents found in top file
2017-12-19 21:23:09,456 [salt.utils.extmods][INFO    ][21447] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-19 21:23:09,459 [salt.utils.extmods][INFO    ][21447] Syncing beacons for environment 'base'
2017-12-19 21:23:09,459 [salt.utils.extmods][INFO    ][21447] Loading cache from salt://_beacons, for base)
2017-12-19 21:23:09,459 [salt.fileclient  ][INFO    ][21447] Caching directory '_beacons/' for environment 'base'
2017-12-19 21:23:09,495 [salt.utils.extmods][INFO    ][21447] Syncing modules for environment 'base'
2017-12-19 21:23:09,495 [salt.utils.extmods][INFO    ][21447] Loading cache from salt://_modules, for base)
2017-12-19 21:23:09,495 [salt.fileclient  ][INFO    ][21447] Caching directory '_modules/' for environment 'base'
2017-12-19 21:23:09,538 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-19 21:23:09,548 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-19 21:23:09,558 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-19 21:23:09,580 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-19 21:23:09,591 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-19 21:23:09,602 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-19 21:23:09,613 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/dockerng_service.py'
2017-12-19 21:23:09,623 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-19 21:23:09,634 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-19 21:23:09,658 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-19 21:23:09,669 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-19 21:23:09,681 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-19 21:23:09,700 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-19 21:23:09,711 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-19 21:23:09,724 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-19 21:23:09,734 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-19 21:23:09,763 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-19 21:23:09,774 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-19 21:23:09,785 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-19 21:23:09,795 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/modelschema.py'
2017-12-19 21:23:09,811 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-19 21:23:09,820 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-19 21:23:09,830 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-19 21:23:09,839 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-19 21:23:09,865 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-19 21:23:10,177 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-19 21:23:10,198 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-19 21:23:10,208 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-19 21:23:10,221 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-19 21:23:10,248 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-19 21:23:10,265 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-19 21:23:10,282 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-19 21:23:10,291 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-19 21:23:10,301 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-19 21:23:10,324 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-19 21:23:10,336 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-19 21:23:10,339 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-19 21:23:10,339 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-19 21:23:10,339 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-19 21:23:10,339 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-19 21:23:10,340 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-19 21:23:10,340 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-19 21:23:10,340 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-19 21:23:10,341 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/dockerng_service.py' to '/var/cache/salt/minion/extmods/modules/dockerng_service.py'
2017-12-19 21:23:10,341 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-19 21:23:10,341 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-19 21:23:10,342 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-19 21:23:10,342 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-19 21:23:10,342 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-19 21:23:10,342 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-19 21:23:10,343 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-19 21:23:10,343 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-19 21:23:10,343 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-19 21:23:10,344 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-19 21:23:10,344 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-19 21:23:10,344 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-19 21:23:10,344 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/modelschema.py' to '/var/cache/salt/minion/extmods/modules/modelschema.py'
2017-12-19 21:23:10,345 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-19 21:23:10,345 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-19 21:23:10,345 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-19 21:23:10,345 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-19 21:23:10,346 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-19 21:23:10,346 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-19 21:23:10,347 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-19 21:23:10,347 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-19 21:23:10,347 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-19 21:23:10,347 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-19 21:23:10,348 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-19 21:23:10,348 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-19 21:23:10,348 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-19 21:23:10,348 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-19 21:23:10,349 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-12-19 21:23:10,349 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-19 21:23:10,349 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-19 21:23:10,354 [salt.utils.extmods][INFO    ][21447] Syncing states for environment 'base'
2017-12-19 21:23:10,354 [salt.utils.extmods][INFO    ][21447] Loading cache from salt://_states, for base)
2017-12-19 21:23:10,355 [salt.fileclient  ][INFO    ][21447] Caching directory '_states/' for environment 'base'
2017-12-19 21:23:10,390 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-19 21:23:10,399 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-19 21:23:10,410 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-19 21:23:10,421 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/dockerng_service.py'
2017-12-19 21:23:10,447 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-19 21:23:10,457 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-19 21:23:10,467 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-19 21:23:10,490 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-19 21:23:10,498 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-19 21:23:10,507 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-19 21:23:10,516 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-19 21:23:10,524 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-19 21:23:10,532 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-19 21:23:10,553 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-19 21:23:10,562 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-19 21:23:10,570 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-19 21:23:10,578 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-19 21:23:10,586 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-19 21:23:10,606 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-19 21:23:10,616 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-19 21:23:10,625 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-19 21:23:10,634 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-19 21:23:10,643 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-19 21:23:10,652 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-19 21:23:10,661 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-19 21:23:10,670 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-19 21:23:10,693 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-19 21:23:10,711 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-19 21:23:10,720 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-19 21:23:10,731 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-19 21:23:10,741 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-19 21:23:10,751 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-19 21:23:10,761 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-19 21:23:10,764 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-19 21:23:10,764 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-19 21:23:10,764 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-19 21:23:10,765 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/dockerng_service.py' to '/var/cache/salt/minion/extmods/states/dockerng_service.py'
2017-12-19 21:23:10,765 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-19 21:23:10,765 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-19 21:23:10,765 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-19 21:23:10,766 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-19 21:23:10,766 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-19 21:23:10,766 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-19 21:23:10,766 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-19 21:23:10,767 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-19 21:23:10,767 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-19 21:23:10,767 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-19 21:23:10,767 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-19 21:23:10,767 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-19 21:23:10,768 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-19 21:23:10,768 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-19 21:23:10,768 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-19 21:23:10,768 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-19 21:23:10,769 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-19 21:23:10,769 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-19 21:23:10,769 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-19 21:23:10,769 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-19 21:23:10,770 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-19 21:23:10,770 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-19 21:23:10,770 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-19 21:23:10,770 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-19 21:23:10,771 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-19 21:23:10,771 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-19 21:23:10,771 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-19 21:23:10,771 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-19 21:23:10,771 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-19 21:23:10,772 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-19 21:23:10,774 [salt.utils.extmods][INFO    ][21447] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-19 21:23:10,776 [salt.utils.extmods][INFO    ][21447] Syncing sdb for environment 'base'
2017-12-19 21:23:10,776 [salt.utils.extmods][INFO    ][21447] Loading cache from salt://_sdb, for base)
2017-12-19 21:23:10,777 [salt.fileclient  ][INFO    ][21447] Caching directory '_sdb/' for environment 'base'
2017-12-19 21:23:10,807 [salt.utils.extmods][INFO    ][21447] Syncing grains for environment 'base'
2017-12-19 21:23:10,807 [salt.utils.extmods][INFO    ][21447] Loading cache from salt://_grains, for base)
2017-12-19 21:23:10,807 [salt.fileclient  ][INFO    ][21447] Caching directory '_grains/' for environment 'base'
2017-12-19 21:23:10,889 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-19 21:23:10,899 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-19 21:23:10,908 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-19 21:23:10,917 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-19 21:23:10,927 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-19 21:23:10,937 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-19 21:23:10,946 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-19 21:23:10,958 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-19 21:23:10,969 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-19 21:23:10,979 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-19 21:23:10,988 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-19 21:23:10,997 [salt.fileclient  ][INFO    ][21447] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-19 21:23:11,000 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-19 21:23:11,001 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-19 21:23:11,001 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-19 21:23:11,001 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-19 21:23:11,001 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-19 21:23:11,001 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-19 21:23:11,002 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-19 21:23:11,002 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-19 21:23:11,002 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-19 21:23:11,002 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-19 21:23:11,002 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-19 21:23:11,003 [salt.utils.extmods][INFO    ][21447] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-19 21:23:11,004 [salt.utils.extmods][INFO    ][21447] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-19 21:23:11,006 [salt.utils.extmods][INFO    ][21447] Syncing renderers for environment 'base'
2017-12-19 21:23:11,006 [salt.utils.extmods][INFO    ][21447] Loading cache from salt://_renderers, for base)
2017-12-19 21:23:11,006 [salt.fileclient  ][INFO    ][21447] Caching directory '_renderers/' for environment 'base'
2017-12-19 21:23:11,037 [salt.utils.extmods][INFO    ][21447] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-19 21:23:11,039 [salt.utils.extmods][INFO    ][21447] Syncing returners for environment 'base'
2017-12-19 21:23:11,040 [salt.utils.extmods][INFO    ][21447] Loading cache from salt://_returners, for base)
2017-12-19 21:23:11,040 [salt.fileclient  ][INFO    ][21447] Caching directory '_returners/' for environment 'base'
2017-12-19 21:23:11,108 [salt.utils.extmods][INFO    ][21447] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-19 21:23:11,111 [salt.utils.extmods][INFO    ][21447] Syncing output for environment 'base'
2017-12-19 21:23:11,112 [salt.utils.extmods][INFO    ][21447] Loading cache from salt://_output, for base)
2017-12-19 21:23:11,112 [salt.fileclient  ][INFO    ][21447] Caching directory '_output/' for environment 'base'
2017-12-19 21:23:11,136 [salt.utils.extmods][INFO    ][21447] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-19 21:23:11,138 [salt.utils.extmods][INFO    ][21447] Syncing utils for environment 'base'
2017-12-19 21:23:11,138 [salt.utils.extmods][INFO    ][21447] Loading cache from salt://_utils, for base)
2017-12-19 21:23:11,138 [salt.fileclient  ][INFO    ][21447] Caching directory '_utils/' for environment 'base'
2017-12-19 21:23:11,161 [salt.utils.extmods][INFO    ][21447] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-19 21:23:11,163 [salt.utils.extmods][INFO    ][21447] Syncing log_handlers for environment 'base'
2017-12-19 21:23:11,163 [salt.utils.extmods][INFO    ][21447] Loading cache from salt://_log_handlers, for base)
2017-12-19 21:23:11,163 [salt.fileclient  ][INFO    ][21447] Caching directory '_log_handlers/' for environment 'base'
2017-12-19 21:23:11,197 [salt.utils.extmods][INFO    ][21447] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-19 21:23:11,199 [salt.utils.extmods][INFO    ][21447] Syncing proxy for environment 'base'
2017-12-19 21:23:11,199 [salt.utils.extmods][INFO    ][21447] Loading cache from salt://_proxy, for base)
2017-12-19 21:23:11,199 [salt.fileclient  ][INFO    ][21447] Caching directory '_proxy/' for environment 'base'
2017-12-19 21:23:11,229 [salt.utils.extmods][INFO    ][21447] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-19 21:23:11,231 [salt.utils.extmods][INFO    ][21447] Syncing engines for environment 'base'
2017-12-19 21:23:11,231 [salt.utils.extmods][INFO    ][21447] Loading cache from salt://_engines, for base)
2017-12-19 21:23:11,231 [salt.fileclient  ][INFO    ][21447] Caching directory '_engines/' for environment 'base'
2017-12-19 21:23:11,267 [salt.minion      ][INFO    ][21447] Returning information for job: 20171219212306976775
2017-12-19 21:23:15,938 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command state.sls with jid 20171219212315940792
2017-12-19 21:23:15,951 [salt.minion      ][INFO    ][21543] Starting a new job with PID 21543
2017-12-19 21:23:16,387 [salt.state       ][INFO    ][21543] Loading fresh modules for state activity
2017-12-19 21:23:16,414 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-19 21:23:16,433 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-19 21:23:16,524 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:16,590 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-19 21:23:16,603 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-19 21:23:16,637 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:16,690 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-19 21:23:16,708 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-19 21:23:16,752 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-19 21:23:16,774 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-19 21:23:16,794 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 21:23:16,813 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-19 21:23:16,819 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:16,830 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:16,857 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-19 21:23:16,870 [py.warnings      ][WARNING ][21543] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-12-19 21:23:16,871 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:17,110 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:17,350 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-19 21:23:17,381 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-19 21:23:17,390 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-19 21:23:17,399 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-19 21:23:17,443 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-19 21:23:17,463 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-19 21:23:17,480 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-19 21:23:17,491 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-19 21:23:17,511 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-19 21:23:17,541 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-19 21:23:17,597 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-19 21:23:17,632 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:17,684 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-19 21:23:17,713 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-19 21:23:17,758 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-19 21:23:17,781 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-19 21:23:17,800 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 21:23:17,816 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-19 21:23:17,822 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:17,836 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:17,862 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-19 21:23:17,876 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:18,104 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:18,340 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-19 21:23:18,360 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-19 21:23:18,372 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-19 21:23:18,384 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-19 21:23:18,419 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-19 21:23:18,433 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-19 21:23:18,476 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-19 21:23:18,489 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-19 21:23:18,540 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-19 21:23:18,576 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-19 21:23:18,642 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-19 21:23:18,700 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:19,103 [salt.state       ][INFO    ][21543] Running state [salt-minion] at time 21:23:19.102623
2017-12-19 21:23:19,103 [salt.state       ][INFO    ][21543] Executing state pkg.installed for salt-minion
2017-12-19 21:23:19,103 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:23:19,362 [salt.state       ][INFO    ][21543] Package salt-minion is already installed
2017-12-19 21:23:19,364 [salt.state       ][INFO    ][21543] Completed state [salt-minion] at time 21:23:19.364167 duration_in_ms=261.544
2017-12-19 21:23:19,365 [salt.state       ][INFO    ][21543] Running state [salt_minion_dependency_packages] at time 21:23:19.364665
2017-12-19 21:23:19,365 [salt.state       ][INFO    ][21543] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-19 21:23:19,368 [salt.state       ][INFO    ][21543] All specified packages are already installed
2017-12-19 21:23:19,372 [salt.state       ][INFO    ][21543] Completed state [salt_minion_dependency_packages] at time 21:23:19.372389 duration_in_ms=7.724
2017-12-19 21:23:19,374 [salt.state       ][INFO    ][21543] Running state [/etc/salt/minion.d/minion.conf] at time 21:23:19.374410
2017-12-19 21:23:19,375 [salt.state       ][INFO    ][21543] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-19 21:23:19,403 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-19 21:23:19,453 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:19,496 [salt.fileclient  ][INFO    ][21543] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-19 21:23:19,529 [salt.state       ][INFO    ][21543] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-19 21:23:19,529 [salt.state       ][INFO    ][21543] Completed state [/etc/salt/minion.d/minion.conf] at time 21:23:19.529115 duration_in_ms=154.705
2017-12-19 21:23:19,529 [salt.state       ][INFO    ][21543] Running state [/etc/salt/minion.d/_virt.conf] at time 21:23:19.529413
2017-12-19 21:23:19,530 [salt.state       ][INFO    ][21543] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-19 21:23:19,550 [salt.state       ][INFO    ][21543] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-19 21:23:19,551 [salt.state       ][INFO    ][21543] Completed state [/etc/salt/minion.d/_virt.conf] at time 21:23:19.550645 duration_in_ms=21.231
2017-12-19 21:23:19,552 [salt.state       ][INFO    ][21543] Running state [salt-minion] at time 21:23:19.551975
2017-12-19 21:23:19,552 [salt.state       ][INFO    ][21543] Executing state service.running for salt-minion
2017-12-19 21:23:19,553 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-19 21:23:19,571 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-19 21:23:19,585 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-19 21:23:19,592 [salt.state       ][INFO    ][21543] The service salt-minion is already running
2017-12-19 21:23:19,593 [salt.state       ][INFO    ][21543] Completed state [salt-minion] at time 21:23:19.592708 duration_in_ms=40.733
2017-12-19 21:23:19,594 [salt.state       ][INFO    ][21543] Running state [/etc/salt/grains.d] at time 21:23:19.594451
2017-12-19 21:23:19,595 [salt.state       ][INFO    ][21543] Executing state file.directory for /etc/salt/grains.d
2017-12-19 21:23:19,595 [salt.state       ][INFO    ][21543] Directory /etc/salt/grains.d is in the correct state
2017-12-19 21:23:19,595 [salt.state       ][INFO    ][21543] Completed state [/etc/salt/grains.d] at time 21:23:19.595394 duration_in_ms=0.943
2017-12-19 21:23:19,596 [salt.state       ][INFO    ][21543] Running state [/etc/salt/grains] at time 21:23:19.595800
2017-12-19 21:23:19,596 [salt.state       ][INFO    ][21543] Executing state file.managed for /etc/salt/grains
2017-12-19 21:23:19,596 [salt.state       ][INFO    ][21543] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-19 21:23:19,596 [salt.state       ][INFO    ][21543] Completed state [/etc/salt/grains] at time 21:23:19.596419 duration_in_ms=0.619
2017-12-19 21:23:19,597 [salt.state       ][INFO    ][21543] Running state [/etc/salt/grains.d/placeholder] at time 21:23:19.596685
2017-12-19 21:23:19,597 [salt.state       ][INFO    ][21543] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-19 21:23:19,597 [salt.state       ][INFO    ][21543] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-19 21:23:19,597 [salt.state       ][INFO    ][21543] Completed state [/etc/salt/grains.d/placeholder] at time 21:23:19.597272 duration_in_ms=0.588
2017-12-19 21:23:19,598 [salt.state       ][INFO    ][21543] Running state [/etc/salt/grains.d/sphinx] at time 21:23:19.597530
2017-12-19 21:23:19,598 [salt.state       ][INFO    ][21543] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-19 21:23:19,637 [salt.state       ][INFO    ][21543] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.142
               - 127.0.0.1
               - 192.168.11.22
-              - 192.168.122.1
         system:
           name: System
           param:

2017-12-19 21:23:19,637 [salt.state       ][INFO    ][21543] Completed state [/etc/salt/grains.d/sphinx] at time 21:23:19.637014 duration_in_ms=39.483
2017-12-19 21:23:19,638 [salt.state       ][INFO    ][21543] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:23:19.637584
2017-12-19 21:23:19,638 [salt.state       ][INFO    ][21543] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-19 21:23:19,638 [salt.state       ][INFO    ][21543] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-19 21:23:19,638 [salt.state       ][INFO    ][21543] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:23:19.638082 duration_in_ms=0.497
2017-12-19 21:23:19,638 [salt.state       ][INFO    ][21543] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:23:19.638208
2017-12-19 21:23:19,638 [salt.state       ][INFO    ][21543] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-19 21:23:19,639 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-12-19 21:23:19,721 [salt.state       ][INFO    ][21543] {'pid': 21613, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-19 21:23:19,727 [salt.state       ][INFO    ][21543] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:23:19.726765 duration_in_ms=88.556
2017-12-19 21:23:19,727 [salt.state       ][INFO    ][21543] Running state [/etc/salt/grains.d/dns_records] at time 21:23:19.727224
2017-12-19 21:23:19,727 [salt.state       ][INFO    ][21543] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-19 21:23:19,799 [salt.state       ][INFO    ][21543] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-19 21:23:19,799 [salt.state       ][INFO    ][21543] Completed state [/etc/salt/grains.d/dns_records] at time 21:23:19.799218 duration_in_ms=71.993
2017-12-19 21:23:19,800 [salt.state       ][INFO    ][21543] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:23:19.799920
2017-12-19 21:23:19,800 [salt.state       ][INFO    ][21543] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-19 21:23:19,801 [salt.state       ][INFO    ][21543] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-19 21:23:19,801 [salt.state       ][INFO    ][21543] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:23:19.800751 duration_in_ms=0.831
2017-12-19 21:23:19,801 [salt.state       ][INFO    ][21543] Running state [/etc/salt/grains.d/salt] at time 21:23:19.801095
2017-12-19 21:23:19,801 [salt.state       ][INFO    ][21543] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-19 21:23:19,838 [salt.state       ][INFO    ][21543] File /etc/salt/grains.d/salt is in the correct state
2017-12-19 21:23:19,838 [salt.state       ][INFO    ][21543] Completed state [/etc/salt/grains.d/salt] at time 21:23:19.838246 duration_in_ms=37.151
2017-12-19 21:23:19,839 [salt.state       ][INFO    ][21543] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:23:19.838881
2017-12-19 21:23:19,839 [salt.state       ][INFO    ][21543] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-19 21:23:19,839 [salt.state       ][INFO    ][21543] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-19 21:23:19,840 [salt.state       ][INFO    ][21543] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:23:19.839501 duration_in_ms=0.62
2017-12-19 21:23:19,841 [salt.state       ][INFO    ][21543] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:23:19.840778
2017-12-19 21:23:19,841 [salt.state       ][INFO    ][21543] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-19 21:23:19,841 [salt.state       ][INFO    ][21543] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-19 21:23:19,841 [salt.state       ][INFO    ][21543] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:23:19.841414 duration_in_ms=0.637
2017-12-19 21:23:19,842 [salt.state       ][INFO    ][21543] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:23:19.841572
2017-12-19 21:23:19,842 [salt.state       ][INFO    ][21543] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-19 21:23:19,843 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-12-19 21:23:19,851 [salt.state       ][INFO    ][21543] {'pid': 21616, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-19 21:23:19,852 [salt.state       ][INFO    ][21543] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:23:19.851596 duration_in_ms=10.023
2017-12-19 21:23:19,852 [salt.state       ][INFO    ][21543] Running state [mine.update] at time 21:23:19.852190
2017-12-19 21:23:19,852 [salt.state       ][INFO    ][21543] Executing state module.wait for mine.update
2017-12-19 21:23:19,853 [salt.state       ][INFO    ][21543] No changes made for mine.update
2017-12-19 21:23:19,853 [salt.state       ][INFO    ][21543] Completed state [mine.update] at time 21:23:19.852769 duration_in_ms=0.578
2017-12-19 21:23:19,853 [salt.state       ][INFO    ][21543] Running state [mine.update] at time 21:23:19.852903
2017-12-19 21:23:19,853 [salt.state       ][INFO    ][21543] Executing state module.mod_watch for mine.update
2017-12-19 21:23:20,373 [salt.state       ][INFO    ][21543] {'ret': True}
2017-12-19 21:23:20,373 [salt.state       ][INFO    ][21543] Completed state [mine.update] at time 21:23:20.372911 duration_in_ms=520.008
2017-12-19 21:23:20,373 [salt.state       ][INFO    ][21543] Running state [ca-certificates] at time 21:23:20.373229
2017-12-19 21:23:20,374 [salt.state       ][INFO    ][21543] Executing state pkg.installed for ca-certificates
2017-12-19 21:23:20,377 [salt.state       ][INFO    ][21543] Package ca-certificates is already installed
2017-12-19 21:23:20,377 [salt.state       ][INFO    ][21543] Completed state [ca-certificates] at time 21:23:20.376894 duration_in_ms=3.666
2017-12-19 21:23:20,377 [salt.state       ][INFO    ][21543] Running state [update-ca-certificates] at time 21:23:20.377454
2017-12-19 21:23:20,378 [salt.state       ][INFO    ][21543] Executing state cmd.wait for update-ca-certificates
2017-12-19 21:23:20,378 [salt.state       ][INFO    ][21543] No changes made for update-ca-certificates
2017-12-19 21:23:20,378 [salt.state       ][INFO    ][21543] Completed state [update-ca-certificates] at time 21:23:20.378096 duration_in_ms=0.641
2017-12-19 21:23:20,378 [salt.state       ][INFO    ][21543] Running state [libvirt-dev] at time 21:23:20.378291
2017-12-19 21:23:20,378 [salt.state       ][INFO    ][21543] Executing state pkg.installed for libvirt-dev
2017-12-19 21:23:20,381 [salt.state       ][INFO    ][21543] Package libvirt-dev is already installed
2017-12-19 21:23:20,381 [salt.state       ][INFO    ][21543] Completed state [libvirt-dev] at time 21:23:20.381431 duration_in_ms=3.141
2017-12-19 21:23:20,382 [salt.state       ][INFO    ][21543] Running state [pkg-config] at time 21:23:20.381625
2017-12-19 21:23:20,382 [salt.state       ][INFO    ][21543] Executing state pkg.installed for pkg-config
2017-12-19 21:23:20,385 [salt.state       ][INFO    ][21543] Package pkg-config is already installed
2017-12-19 21:23:20,385 [salt.state       ][INFO    ][21543] Completed state [pkg-config] at time 21:23:20.384801 duration_in_ms=3.176
2017-12-19 21:23:20,385 [salt.state       ][INFO    ][21543] Running state [virtng.init] at time 21:23:20.384999
2017-12-19 21:23:20,385 [salt.state       ][INFO    ][21543] Executing state module.run for virtng.init
2017-12-19 21:23:20,506 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command ['git', '--version'] in directory '/root'
2017-12-19 21:23:20,568 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:20,587 [salt.state       ][INFO    ][21543] unless execution succeeded
2017-12-19 21:23:20,587 [salt.state       ][INFO    ][21543] Completed state [virtng.init] at time 21:23:20.587438 duration_in_ms=202.437
2017-12-19 21:23:20,588 [salt.state       ][INFO    ][21543] Running state [virt.set_autostart] at time 21:23:20.587703
2017-12-19 21:23:20,588 [salt.state       ][INFO    ][21543] Executing state module.run for virt.set_autostart
2017-12-19 21:23:20,590 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:20,607 [salt.state       ][INFO    ][21543] unless execution succeeded
2017-12-19 21:23:20,627 [salt.state       ][INFO    ][21543] Completed state [virt.set_autostart] at time 21:23:20.626761 duration_in_ms=39.056
2017-12-19 21:23:20,627 [salt.state       ][INFO    ][21543] Running state [virtng.init] at time 21:23:20.627159
2017-12-19 21:23:20,627 [salt.state       ][INFO    ][21543] Executing state module.run for virtng.init
2017-12-19 21:23:20,629 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:20,646 [salt.state       ][INFO    ][21543] unless execution succeeded
2017-12-19 21:23:20,646 [salt.state       ][INFO    ][21543] Completed state [virtng.init] at time 21:23:20.646212 duration_in_ms=19.053
2017-12-19 21:23:20,646 [salt.state       ][INFO    ][21543] Running state [virt.set_autostart] at time 21:23:20.646438
2017-12-19 21:23:20,647 [salt.state       ][INFO    ][21543] Executing state module.run for virt.set_autostart
2017-12-19 21:23:20,649 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:20,664 [salt.state       ][INFO    ][21543] unless execution succeeded
2017-12-19 21:23:20,665 [salt.state       ][INFO    ][21543] Completed state [virt.set_autostart] at time 21:23:20.664597 duration_in_ms=18.158
2017-12-19 21:23:20,665 [salt.state       ][INFO    ][21543] Running state [virtng.init] at time 21:23:20.664830
2017-12-19 21:23:20,665 [salt.state       ][INFO    ][21543] Executing state module.run for virtng.init
2017-12-19 21:23:20,667 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:20,683 [salt.state       ][INFO    ][21543] unless execution succeeded
2017-12-19 21:23:20,683 [salt.state       ][INFO    ][21543] Completed state [virtng.init] at time 21:23:20.683218 duration_in_ms=18.388
2017-12-19 21:23:20,683 [salt.state       ][INFO    ][21543] Running state [virt.set_autostart] at time 21:23:20.683454
2017-12-19 21:23:20,684 [salt.state       ][INFO    ][21543] Executing state module.run for virt.set_autostart
2017-12-19 21:23:20,686 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:20,701 [salt.state       ][INFO    ][21543] unless execution succeeded
2017-12-19 21:23:20,703 [salt.state       ][INFO    ][21543] Completed state [virt.set_autostart] at time 21:23:20.702616 duration_in_ms=19.162
2017-12-19 21:23:20,703 [salt.state       ][INFO    ][21543] Running state [virtng.init] at time 21:23:20.702850
2017-12-19 21:23:20,703 [salt.state       ][INFO    ][21543] Executing state module.run for virtng.init
2017-12-19 21:23:20,705 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:20,720 [salt.state       ][INFO    ][21543] unless execution succeeded
2017-12-19 21:23:20,720 [salt.state       ][INFO    ][21543] Completed state [virtng.init] at time 21:23:20.720349 duration_in_ms=17.499
2017-12-19 21:23:20,721 [salt.state       ][INFO    ][21543] Running state [virt.set_autostart] at time 21:23:20.720589
2017-12-19 21:23:20,721 [salt.state       ][INFO    ][21543] Executing state module.run for virt.set_autostart
2017-12-19 21:23:20,723 [salt.loaded.int.module.cmdmod][INFO    ][21543] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:20,739 [salt.state       ][INFO    ][21543] unless execution succeeded
2017-12-19 21:23:20,739 [salt.state       ][INFO    ][21543] Completed state [virt.set_autostart] at time 21:23:20.738948 duration_in_ms=18.359
2017-12-19 21:23:20,741 [salt.minion      ][INFO    ][21543] Returning information for job: 20171219212315940792
2017-12-19 21:23:47,076 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command state.sls with jid 20171219212347074020
2017-12-19 21:23:47,089 [salt.minion      ][INFO    ][21664] Starting a new job with PID 21664
2017-12-19 21:23:49,547 [salt.state       ][INFO    ][21664] Loading fresh modules for state activity
2017-12-19 21:23:49,574 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-19 21:23:49,599 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-19 21:23:49,669 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:49,739 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-19 21:23:49,754 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-19 21:23:49,780 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:49,840 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-19 21:23:49,860 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-19 21:23:49,922 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-19 21:23:49,946 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-19 21:23:49,960 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 21:23:49,976 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-19 21:23:49,985 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:49,998 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:50,019 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-19 21:23:50,034 [py.warnings      ][WARNING ][21664] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-12-19 21:23:50,034 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:50,257 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:50,487 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-19 21:23:50,505 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-19 21:23:50,517 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-19 21:23:50,528 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-19 21:23:50,563 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-19 21:23:50,578 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-19 21:23:50,600 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-19 21:23:50,612 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-19 21:23:50,628 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-19 21:23:50,660 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-19 21:23:50,716 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-19 21:23:50,737 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:50,793 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-19 21:23:50,810 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-19 21:23:50,853 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-19 21:23:50,877 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-19 21:23:50,890 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 21:23:50,907 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-19 21:23:50,914 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:50,925 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:50,947 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-19 21:23:50,962 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:51,188 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:51,418 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-19 21:23:51,433 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-19 21:23:51,443 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-19 21:23:51,452 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-19 21:23:51,483 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-19 21:23:51,495 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-19 21:23:51,535 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-19 21:23:51,546 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-19 21:23:51,566 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-19 21:23:51,602 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-19 21:23:51,675 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-19 21:23:51,732 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:52,029 [salt.state       ][INFO    ][21664] Running state [salt-minion] at time 21:23:52.029333
2017-12-19 21:23:52,030 [salt.state       ][INFO    ][21664] Executing state pkg.installed for salt-minion
2017-12-19 21:23:52,030 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:23:52,280 [salt.state       ][INFO    ][21664] Package salt-minion is already installed
2017-12-19 21:23:52,281 [salt.state       ][INFO    ][21664] Completed state [salt-minion] at time 21:23:52.280625 duration_in_ms=251.292
2017-12-19 21:23:52,281 [salt.state       ][INFO    ][21664] Running state [salt_minion_dependency_packages] at time 21:23:52.280838
2017-12-19 21:23:52,281 [salt.state       ][INFO    ][21664] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-19 21:23:52,284 [salt.state       ][INFO    ][21664] All specified packages are already installed
2017-12-19 21:23:52,284 [salt.state       ][INFO    ][21664] Completed state [salt_minion_dependency_packages] at time 21:23:52.283752 duration_in_ms=2.914
2017-12-19 21:23:52,285 [salt.state       ][INFO    ][21664] Running state [/etc/salt/minion.d/minion.conf] at time 21:23:52.285207
2017-12-19 21:23:52,285 [salt.state       ][INFO    ][21664] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-19 21:23:52,320 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-19 21:23:52,376 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:52,427 [salt.fileclient  ][INFO    ][21664] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-19 21:23:52,464 [salt.state       ][INFO    ][21664] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-19 21:23:52,464 [salt.state       ][INFO    ][21664] Completed state [/etc/salt/minion.d/minion.conf] at time 21:23:52.464036 duration_in_ms=178.829
2017-12-19 21:23:52,465 [salt.state       ][INFO    ][21664] Running state [/etc/salt/minion.d/_virt.conf] at time 21:23:52.464497
2017-12-19 21:23:52,465 [salt.state       ][INFO    ][21664] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-19 21:23:52,477 [salt.state       ][INFO    ][21664] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-19 21:23:52,477 [salt.state       ][INFO    ][21664] Completed state [/etc/salt/minion.d/_virt.conf] at time 21:23:52.476945 duration_in_ms=12.447
2017-12-19 21:23:52,479 [salt.state       ][INFO    ][21664] Running state [salt-minion] at time 21:23:52.478543
2017-12-19 21:23:52,479 [salt.state       ][INFO    ][21664] Executing state service.running for salt-minion
2017-12-19 21:23:52,479 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-19 21:23:52,498 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-19 21:23:52,506 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-19 21:23:52,520 [salt.state       ][INFO    ][21664] The service salt-minion is already running
2017-12-19 21:23:52,520 [salt.state       ][INFO    ][21664] Completed state [salt-minion] at time 21:23:52.520031 duration_in_ms=41.487
2017-12-19 21:23:52,521 [salt.state       ][INFO    ][21664] Running state [/etc/salt/grains.d] at time 21:23:52.521348
2017-12-19 21:23:52,522 [salt.state       ][INFO    ][21664] Executing state file.directory for /etc/salt/grains.d
2017-12-19 21:23:52,522 [salt.state       ][INFO    ][21664] Directory /etc/salt/grains.d is in the correct state
2017-12-19 21:23:52,522 [salt.state       ][INFO    ][21664] Completed state [/etc/salt/grains.d] at time 21:23:52.522207 duration_in_ms=0.86
2017-12-19 21:23:52,523 [salt.state       ][INFO    ][21664] Running state [/etc/salt/grains] at time 21:23:52.522589
2017-12-19 21:23:52,523 [salt.state       ][INFO    ][21664] Executing state file.managed for /etc/salt/grains
2017-12-19 21:23:52,523 [salt.state       ][INFO    ][21664] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-19 21:23:52,523 [salt.state       ][INFO    ][21664] Completed state [/etc/salt/grains] at time 21:23:52.523191 duration_in_ms=0.602
2017-12-19 21:23:52,523 [salt.state       ][INFO    ][21664] Running state [/etc/salt/grains.d/placeholder] at time 21:23:52.523442
2017-12-19 21:23:52,524 [salt.state       ][INFO    ][21664] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-19 21:23:52,524 [salt.state       ][INFO    ][21664] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-19 21:23:52,524 [salt.state       ][INFO    ][21664] Completed state [/etc/salt/grains.d/placeholder] at time 21:23:52.524002 duration_in_ms=0.559
2017-12-19 21:23:52,524 [salt.state       ][INFO    ][21664] Running state [/etc/salt/grains.d/sphinx] at time 21:23:52.524251
2017-12-19 21:23:52,524 [salt.state       ][INFO    ][21664] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-19 21:23:52,604 [salt.state       ][INFO    ][21664] File /etc/salt/grains.d/sphinx is in the correct state
2017-12-19 21:23:52,605 [salt.state       ][INFO    ][21664] Completed state [/etc/salt/grains.d/sphinx] at time 21:23:52.604537 duration_in_ms=80.284
2017-12-19 21:23:52,605 [salt.state       ][INFO    ][21664] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:23:52.605212
2017-12-19 21:23:52,605 [salt.state       ][INFO    ][21664] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-19 21:23:52,606 [salt.state       ][INFO    ][21664] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-19 21:23:52,606 [salt.state       ][INFO    ][21664] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:23:52.605882 duration_in_ms=0.67
2017-12-19 21:23:52,606 [salt.state       ][INFO    ][21664] Running state [/etc/salt/grains.d/dns_records] at time 21:23:52.606197
2017-12-19 21:23:52,606 [salt.state       ][INFO    ][21664] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-19 21:23:52,618 [salt.state       ][INFO    ][21664] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-19 21:23:52,618 [salt.state       ][INFO    ][21664] Completed state [/etc/salt/grains.d/dns_records] at time 21:23:52.617853 duration_in_ms=11.655
2017-12-19 21:23:52,619 [salt.state       ][INFO    ][21664] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:23:52.618500
2017-12-19 21:23:52,619 [salt.state       ][INFO    ][21664] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-19 21:23:52,619 [salt.state       ][INFO    ][21664] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-19 21:23:52,619 [salt.state       ][INFO    ][21664] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:23:52.619170 duration_in_ms=0.67
2017-12-19 21:23:52,620 [salt.state       ][INFO    ][21664] Running state [/etc/salt/grains.d/salt] at time 21:23:52.619503
2017-12-19 21:23:52,620 [salt.state       ][INFO    ][21664] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-19 21:23:52,646 [salt.state       ][INFO    ][21664] File /etc/salt/grains.d/salt is in the correct state
2017-12-19 21:23:52,646 [salt.state       ][INFO    ][21664] Completed state [/etc/salt/grains.d/salt] at time 21:23:52.646439 duration_in_ms=26.936
2017-12-19 21:23:52,647 [salt.state       ][INFO    ][21664] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:23:52.647070
2017-12-19 21:23:52,647 [salt.state       ][INFO    ][21664] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-19 21:23:52,648 [salt.state       ][INFO    ][21664] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-19 21:23:52,648 [salt.state       ][INFO    ][21664] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:23:52.647693 duration_in_ms=0.623
2017-12-19 21:23:52,649 [salt.state       ][INFO    ][21664] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:23:52.648943
2017-12-19 21:23:52,649 [salt.state       ][INFO    ][21664] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-19 21:23:52,649 [salt.state       ][INFO    ][21664] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-19 21:23:52,650 [salt.state       ][INFO    ][21664] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:23:52.649545 duration_in_ms=0.601
2017-12-19 21:23:52,650 [salt.state       ][INFO    ][21664] Running state [mine.update] at time 21:23:52.649978
2017-12-19 21:23:52,650 [salt.state       ][INFO    ][21664] Executing state module.wait for mine.update
2017-12-19 21:23:52,650 [salt.state       ][INFO    ][21664] No changes made for mine.update
2017-12-19 21:23:52,651 [salt.state       ][INFO    ][21664] Completed state [mine.update] at time 21:23:52.650548 duration_in_ms=0.57
2017-12-19 21:23:52,651 [salt.state       ][INFO    ][21664] Running state [ca-certificates] at time 21:23:52.650725
2017-12-19 21:23:52,651 [salt.state       ][INFO    ][21664] Executing state pkg.installed for ca-certificates
2017-12-19 21:23:52,654 [salt.state       ][INFO    ][21664] Package ca-certificates is already installed
2017-12-19 21:23:52,654 [salt.state       ][INFO    ][21664] Completed state [ca-certificates] at time 21:23:52.654267 duration_in_ms=3.542
2017-12-19 21:23:52,655 [salt.state       ][INFO    ][21664] Running state [update-ca-certificates] at time 21:23:52.654728
2017-12-19 21:23:52,655 [salt.state       ][INFO    ][21664] Executing state cmd.wait for update-ca-certificates
2017-12-19 21:23:52,655 [salt.state       ][INFO    ][21664] No changes made for update-ca-certificates
2017-12-19 21:23:52,655 [salt.state       ][INFO    ][21664] Completed state [update-ca-certificates] at time 21:23:52.655313 duration_in_ms=0.585
2017-12-19 21:23:52,656 [salt.state       ][INFO    ][21664] Running state [libvirt-dev] at time 21:23:52.655490
2017-12-19 21:23:52,656 [salt.state       ][INFO    ][21664] Executing state pkg.installed for libvirt-dev
2017-12-19 21:23:52,658 [salt.state       ][INFO    ][21664] Package libvirt-dev is already installed
2017-12-19 21:23:52,659 [salt.state       ][INFO    ][21664] Completed state [libvirt-dev] at time 21:23:52.658560 duration_in_ms=3.071
2017-12-19 21:23:52,659 [salt.state       ][INFO    ][21664] Running state [pkg-config] at time 21:23:52.658756
2017-12-19 21:23:52,659 [salt.state       ][INFO    ][21664] Executing state pkg.installed for pkg-config
2017-12-19 21:23:52,662 [salt.state       ][INFO    ][21664] Package pkg-config is already installed
2017-12-19 21:23:52,662 [salt.state       ][INFO    ][21664] Completed state [pkg-config] at time 21:23:52.661802 duration_in_ms=3.063
2017-12-19 21:23:52,662 [salt.state       ][INFO    ][21664] Running state [virtng.init] at time 21:23:52.661981
2017-12-19 21:23:52,662 [salt.state       ][INFO    ][21664] Executing state module.run for virtng.init
2017-12-19 21:23:52,791 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command ['git', '--version'] in directory '/root'
2017-12-19 21:23:52,830 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:52,848 [salt.state       ][INFO    ][21664] unless execution succeeded
2017-12-19 21:23:52,849 [salt.state       ][INFO    ][21664] Completed state [virtng.init] at time 21:23:52.848522 duration_in_ms=186.541
2017-12-19 21:23:52,849 [salt.state       ][INFO    ][21664] Running state [virt.set_autostart] at time 21:23:52.848759
2017-12-19 21:23:52,849 [salt.state       ][INFO    ][21664] Executing state module.run for virt.set_autostart
2017-12-19 21:23:52,851 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:52,868 [salt.state       ][INFO    ][21664] unless execution succeeded
2017-12-19 21:23:52,868 [salt.state       ][INFO    ][21664] Completed state [virt.set_autostart] at time 21:23:52.868113 duration_in_ms=19.353
2017-12-19 21:23:52,868 [salt.state       ][INFO    ][21664] Running state [virtng.init] at time 21:23:52.868395
2017-12-19 21:23:52,869 [salt.state       ][INFO    ][21664] Executing state module.run for virtng.init
2017-12-19 21:23:52,871 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:52,886 [salt.state       ][INFO    ][21664] unless execution succeeded
2017-12-19 21:23:52,886 [salt.state       ][INFO    ][21664] Completed state [virtng.init] at time 21:23:52.886189 duration_in_ms=17.793
2017-12-19 21:23:52,886 [salt.state       ][INFO    ][21664] Running state [virt.set_autostart] at time 21:23:52.886411
2017-12-19 21:23:52,887 [salt.state       ][INFO    ][21664] Executing state module.run for virt.set_autostart
2017-12-19 21:23:52,889 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:52,903 [salt.state       ][INFO    ][21664] unless execution succeeded
2017-12-19 21:23:52,903 [salt.state       ][INFO    ][21664] Completed state [virt.set_autostart] at time 21:23:52.902706 duration_in_ms=16.295
2017-12-19 21:23:52,903 [salt.state       ][INFO    ][21664] Running state [virtng.init] at time 21:23:52.902920
2017-12-19 21:23:52,903 [salt.state       ][INFO    ][21664] Executing state module.run for virtng.init
2017-12-19 21:23:52,905 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:52,918 [salt.state       ][INFO    ][21664] unless execution succeeded
2017-12-19 21:23:52,919 [salt.state       ][INFO    ][21664] Completed state [virtng.init] at time 21:23:52.918471 duration_in_ms=15.55
2017-12-19 21:23:52,919 [salt.state       ][INFO    ][21664] Running state [virt.set_autostart] at time 21:23:52.918687
2017-12-19 21:23:52,919 [salt.state       ][INFO    ][21664] Executing state module.run for virt.set_autostart
2017-12-19 21:23:52,921 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:52,936 [salt.state       ][INFO    ][21664] unless execution succeeded
2017-12-19 21:23:52,936 [salt.state       ][INFO    ][21664] Completed state [virt.set_autostart] at time 21:23:52.936423 duration_in_ms=17.736
2017-12-19 21:23:52,937 [salt.state       ][INFO    ][21664] Running state [virtng.init] at time 21:23:52.936670
2017-12-19 21:23:52,937 [salt.state       ][INFO    ][21664] Executing state module.run for virtng.init
2017-12-19 21:23:52,939 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:52,953 [salt.state       ][INFO    ][21664] unless execution succeeded
2017-12-19 21:23:52,953 [salt.state       ][INFO    ][21664] Completed state [virtng.init] at time 21:23:52.953190 duration_in_ms=16.519
2017-12-19 21:23:52,953 [salt.state       ][INFO    ][21664] Running state [virt.set_autostart] at time 21:23:52.953429
2017-12-19 21:23:52,954 [salt.state       ][INFO    ][21664] Executing state module.run for virt.set_autostart
2017-12-19 21:23:52,956 [salt.loaded.int.module.cmdmod][INFO    ][21664] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:52,970 [salt.state       ][INFO    ][21664] unless execution succeeded
2017-12-19 21:23:52,971 [salt.state       ][INFO    ][21664] Completed state [virt.set_autostart] at time 21:23:52.970651 duration_in_ms=17.222
2017-12-19 21:23:52,973 [salt.minion      ][INFO    ][21664] Returning information for job: 20171219212347074020
2017-12-19 21:24:32,882 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171219212432873562
2017-12-19 21:24:32,901 [salt.minion      ][INFO    ][21774] Starting a new job with PID 21774
2017-12-19 21:24:36,158 [salt.state       ][INFO    ][21774] Loading fresh modules for state activity
2017-12-19 21:24:36,241 [salt.state       ][ERROR   ][21774] No contents found in top file
2017-12-19 21:24:36,242 [salt.utils.extmods][INFO    ][21774] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-19 21:24:36,244 [salt.utils.extmods][INFO    ][21774] Syncing beacons for environment 'base'
2017-12-19 21:24:36,245 [salt.utils.extmods][INFO    ][21774] Loading cache from salt://_beacons, for base)
2017-12-19 21:24:36,245 [salt.fileclient  ][INFO    ][21774] Caching directory '_beacons/' for environment 'base'
2017-12-19 21:24:36,266 [salt.utils.extmods][INFO    ][21774] Syncing modules for environment 'base'
2017-12-19 21:24:36,267 [salt.utils.extmods][INFO    ][21774] Loading cache from salt://_modules, for base)
2017-12-19 21:24:36,267 [salt.fileclient  ][INFO    ][21774] Caching directory '_modules/' for environment 'base'
2017-12-19 21:24:36,295 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-19 21:24:36,304 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-19 21:24:36,498 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-19 21:24:36,508 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-19 21:24:36,524 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-19 21:24:36,543 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-19 21:24:36,549 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/dockerng_service.py'
2017-12-19 21:24:36,567 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-19 21:24:36,577 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-19 21:24:36,589 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-19 21:24:36,610 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-19 21:24:36,631 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-19 21:24:36,665 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-19 21:24:36,694 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-19 21:24:36,702 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-19 21:24:36,734 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-19 21:24:36,773 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-19 21:24:36,783 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-19 21:24:36,796 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-19 21:24:36,818 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/modelschema.py'
2017-12-19 21:24:36,835 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-19 21:24:36,847 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-19 21:24:36,857 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-19 21:24:36,900 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-19 21:24:36,922 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-19 21:24:36,945 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-19 21:24:36,972 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-19 21:24:36,997 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-19 21:24:37,004 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-19 21:24:37,019 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-19 21:24:37,026 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-19 21:24:37,052 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-19 21:24:37,064 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-19 21:24:37,076 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-19 21:24:37,086 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-19 21:24:37,097 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-19 21:24:37,100 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-19 21:24:37,100 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-19 21:24:37,101 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-19 21:24:37,101 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-19 21:24:37,101 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-19 21:24:37,102 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-19 21:24:37,102 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-19 21:24:37,102 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/dockerng_service.py' to '/var/cache/salt/minion/extmods/modules/dockerng_service.py'
2017-12-19 21:24:37,102 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-19 21:24:37,103 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-19 21:24:37,103 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-19 21:24:37,103 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-19 21:24:37,103 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-19 21:24:37,104 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-19 21:24:37,104 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-19 21:24:37,105 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-19 21:24:37,105 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-19 21:24:37,105 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-19 21:24:37,105 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-19 21:24:37,106 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-19 21:24:37,106 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/modelschema.py' to '/var/cache/salt/minion/extmods/modules/modelschema.py'
2017-12-19 21:24:37,106 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-19 21:24:37,106 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-19 21:24:37,106 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-19 21:24:37,107 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-19 21:24:37,107 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-19 21:24:37,107 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-19 21:24:37,108 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-19 21:24:37,108 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-19 21:24:37,108 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-19 21:24:37,109 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-19 21:24:37,109 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-19 21:24:37,109 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-19 21:24:37,109 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-19 21:24:37,109 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-19 21:24:37,110 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-12-19 21:24:37,110 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-19 21:24:37,110 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-19 21:24:37,114 [salt.utils.extmods][INFO    ][21774] Syncing states for environment 'base'
2017-12-19 21:24:37,114 [salt.utils.extmods][INFO    ][21774] Loading cache from salt://_states, for base)
2017-12-19 21:24:37,114 [salt.fileclient  ][INFO    ][21774] Caching directory '_states/' for environment 'base'
2017-12-19 21:24:37,156 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-19 21:24:37,173 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-19 21:24:37,208 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-19 21:24:37,215 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/dockerng_service.py'
2017-12-19 21:24:37,239 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-19 21:24:37,246 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-19 21:24:37,253 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-19 21:24:37,290 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-19 21:24:37,342 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-19 21:24:37,355 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-19 21:24:37,396 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-19 21:24:37,420 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-19 21:24:37,448 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-19 21:24:37,501 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-19 21:24:37,509 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-19 21:24:37,540 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-19 21:24:37,552 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-19 21:24:37,593 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-19 21:24:37,603 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-19 21:24:37,609 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-19 21:24:37,659 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-19 21:24:37,685 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-19 21:24:37,712 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-19 21:24:37,721 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-19 21:24:37,733 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-19 21:24:37,741 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-19 21:24:37,749 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-19 21:24:37,801 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-19 21:24:37,827 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-19 21:24:37,844 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-19 21:24:37,856 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-19 21:24:37,879 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-19 21:24:37,886 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-19 21:24:37,889 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-19 21:24:37,889 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-19 21:24:37,889 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-19 21:24:37,890 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/dockerng_service.py' to '/var/cache/salt/minion/extmods/states/dockerng_service.py'
2017-12-19 21:24:37,890 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-19 21:24:37,890 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-19 21:24:37,890 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-19 21:24:37,890 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-19 21:24:37,891 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-19 21:24:37,891 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-19 21:24:37,891 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-19 21:24:37,891 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-19 21:24:37,891 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-19 21:24:37,892 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-19 21:24:37,892 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-19 21:24:37,892 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-19 21:24:37,892 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-19 21:24:37,892 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-19 21:24:37,893 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-19 21:24:37,893 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-19 21:24:37,893 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-19 21:24:37,893 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-19 21:24:37,893 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-19 21:24:37,893 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-19 21:24:37,894 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-19 21:24:37,894 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-19 21:24:37,894 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-19 21:24:37,894 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-19 21:24:37,894 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-19 21:24:37,895 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-19 21:24:37,895 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-19 21:24:37,895 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-19 21:24:37,895 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-19 21:24:37,895 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-19 21:24:37,897 [salt.utils.extmods][INFO    ][21774] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-19 21:24:37,900 [salt.utils.extmods][INFO    ][21774] Syncing sdb for environment 'base'
2017-12-19 21:24:37,900 [salt.utils.extmods][INFO    ][21774] Loading cache from salt://_sdb, for base)
2017-12-19 21:24:37,901 [salt.fileclient  ][INFO    ][21774] Caching directory '_sdb/' for environment 'base'
2017-12-19 21:24:37,942 [salt.utils.extmods][INFO    ][21774] Syncing grains for environment 'base'
2017-12-19 21:24:37,943 [salt.utils.extmods][INFO    ][21774] Loading cache from salt://_grains, for base)
2017-12-19 21:24:37,943 [salt.fileclient  ][INFO    ][21774] Caching directory '_grains/' for environment 'base'
2017-12-19 21:24:37,989 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-19 21:24:38,016 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-19 21:24:38,029 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-19 21:24:38,037 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-19 21:24:38,093 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-19 21:24:38,122 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-19 21:24:38,131 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-19 21:24:38,145 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-19 21:24:38,176 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-19 21:24:38,216 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-19 21:24:38,231 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-19 21:24:38,258 [salt.fileclient  ][INFO    ][21774] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-19 21:24:38,261 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-19 21:24:38,261 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-19 21:24:38,261 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-19 21:24:38,262 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-19 21:24:38,262 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-19 21:24:38,262 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-19 21:24:38,262 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-19 21:24:38,262 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-19 21:24:38,263 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-19 21:24:38,263 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-19 21:24:38,263 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-19 21:24:38,263 [salt.utils.extmods][INFO    ][21774] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-19 21:24:38,264 [salt.utils.extmods][INFO    ][21774] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-19 21:24:38,267 [salt.utils.extmods][INFO    ][21774] Syncing renderers for environment 'base'
2017-12-19 21:24:38,267 [salt.utils.extmods][INFO    ][21774] Loading cache from salt://_renderers, for base)
2017-12-19 21:24:38,267 [salt.fileclient  ][INFO    ][21774] Caching directory '_renderers/' for environment 'base'
2017-12-19 21:24:38,297 [salt.utils.extmods][INFO    ][21774] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-19 21:24:38,299 [salt.utils.extmods][INFO    ][21774] Syncing returners for environment 'base'
2017-12-19 21:24:38,299 [salt.utils.extmods][INFO    ][21774] Loading cache from salt://_returners, for base)
2017-12-19 21:24:38,300 [salt.fileclient  ][INFO    ][21774] Caching directory '_returners/' for environment 'base'
2017-12-19 21:24:38,342 [salt.utils.extmods][INFO    ][21774] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-19 21:24:38,344 [salt.utils.extmods][INFO    ][21774] Syncing output for environment 'base'
2017-12-19 21:24:38,345 [salt.utils.extmods][INFO    ][21774] Loading cache from salt://_output, for base)
2017-12-19 21:24:38,345 [salt.fileclient  ][INFO    ][21774] Caching directory '_output/' for environment 'base'
2017-12-19 21:24:38,373 [salt.utils.extmods][INFO    ][21774] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-19 21:24:38,375 [salt.utils.extmods][INFO    ][21774] Syncing utils for environment 'base'
2017-12-19 21:24:38,376 [salt.utils.extmods][INFO    ][21774] Loading cache from salt://_utils, for base)
2017-12-19 21:24:38,376 [salt.fileclient  ][INFO    ][21774] Caching directory '_utils/' for environment 'base'
2017-12-19 21:24:38,410 [salt.utils.extmods][INFO    ][21774] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-19 21:24:38,412 [salt.utils.extmods][INFO    ][21774] Syncing log_handlers for environment 'base'
2017-12-19 21:24:38,412 [salt.utils.extmods][INFO    ][21774] Loading cache from salt://_log_handlers, for base)
2017-12-19 21:24:38,412 [salt.fileclient  ][INFO    ][21774] Caching directory '_log_handlers/' for environment 'base'
2017-12-19 21:24:38,436 [salt.utils.extmods][INFO    ][21774] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-19 21:24:38,438 [salt.utils.extmods][INFO    ][21774] Syncing proxy for environment 'base'
2017-12-19 21:24:38,438 [salt.utils.extmods][INFO    ][21774] Loading cache from salt://_proxy, for base)
2017-12-19 21:24:38,439 [salt.fileclient  ][INFO    ][21774] Caching directory '_proxy/' for environment 'base'
2017-12-19 21:24:38,460 [salt.utils.extmods][INFO    ][21774] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-19 21:24:38,462 [salt.utils.extmods][INFO    ][21774] Syncing engines for environment 'base'
2017-12-19 21:24:38,463 [salt.utils.extmods][INFO    ][21774] Loading cache from salt://_engines, for base)
2017-12-19 21:24:38,463 [salt.fileclient  ][INFO    ][21774] Caching directory '_engines/' for environment 'base'
2017-12-19 21:24:38,484 [salt.minion      ][INFO    ][21774] Returning information for job: 20171219212432873562
2017-12-19 21:39:02,084 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command test.ping with jid 20171219213902072841
2017-12-19 21:39:02,101 [salt.minion      ][INFO    ][22053] Starting a new job with PID 22053
2017-12-19 21:39:02,126 [salt.minion      ][INFO    ][22053] Returning information for job: 20171219213902072841
2017-12-19 21:40:43,486 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command state.sls with jid 20171219214043474677
2017-12-19 21:40:43,501 [salt.minion      ][INFO    ][22075] Starting a new job with PID 22075
2017-12-19 21:40:43,948 [salt.state       ][INFO    ][22075] Loading fresh modules for state activity
2017-12-19 21:40:43,973 [salt.fileclient  ][INFO    ][22075] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-19 21:40:43,990 [salt.fileclient  ][INFO    ][22075] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-19 21:40:44,015 [salt.fileclient  ][INFO    ][22075] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 21:40:44,318 [salt.state       ][INFO    ][22075] Running state [lsof] at time 21:40:44.318290
2017-12-19 21:40:44,319 [salt.state       ][INFO    ][22075] Executing state pkg.installed for lsof
2017-12-19 21:40:44,319 [salt.loaded.int.module.cmdmod][INFO    ][22075] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:40:44,595 [salt.state       ][INFO    ][22075] Package lsof is already installed
2017-12-19 21:40:44,596 [salt.state       ][INFO    ][22075] Completed state [lsof] at time 21:40:44.595603 duration_in_ms=277.314
2017-12-19 21:40:44,596 [salt.state       ][INFO    ][22075] Running state [keepalived] at time 21:40:44.595808
2017-12-19 21:40:44,596 [salt.state       ][INFO    ][22075] Executing state pkg.installed for keepalived
2017-12-19 21:40:44,611 [salt.loaded.int.module.cmdmod][INFO    ][22075] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-19 21:40:47,794 [salt.loaded.int.module.cmdmod][INFO    ][22075] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-12-19 21:40:53,528 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command saltutil.find_job with jid 20171219214053514762
2017-12-19 21:40:53,541 [salt.minion      ][INFO    ][23295] Starting a new job with PID 23295
2017-12-19 21:40:53,551 [salt.minion      ][INFO    ][23295] Returning information for job: 20171219214053514762
2017-12-19 21:40:55,282 [salt.loaded.int.module.cmdmod][INFO    ][22075] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:40:55,305 [salt.state       ][INFO    ][22075] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-12-19 21:40:55,313 [salt.state       ][INFO    ][22075] Loading fresh modules for state activity
2017-12-19 21:40:55,325 [salt.state       ][INFO    ][22075] Completed state [keepalived] at time 21:40:55.324938 duration_in_ms=10729.13
2017-12-19 21:40:55,327 [salt.state       ][INFO    ][22075] Running state [/etc/keepalived/keepalived.conf] at time 21:40:55.326967
2017-12-19 21:40:55,327 [salt.state       ][INFO    ][22075] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-19 21:40:55,355 [salt.fileclient  ][INFO    ][22075] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-19 21:40:55,386 [salt.fileclient  ][INFO    ][22075] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 21:40:55,391 [salt.state       ][INFO    ][22075] File changed:
New file
2017-12-19 21:40:55,391 [salt.state       ][INFO    ][22075] Completed state [/etc/keepalived/keepalived.conf] at time 21:40:55.391426 duration_in_ms=64.459
2017-12-19 21:40:55,450 [salt.state       ][INFO    ][22075] Running state [keepalived] at time 21:40:55.449897
2017-12-19 21:40:55,450 [salt.state       ][INFO    ][22075] Executing state service.running for keepalived
2017-12-19 21:40:55,452 [salt.loaded.int.module.cmdmod][INFO    ][22075] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-19 21:40:55,460 [salt.loaded.int.module.cmdmod][INFO    ][22075] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-19 21:40:55,467 [salt.loaded.int.module.cmdmod][INFO    ][22075] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-19 21:40:55,474 [salt.loaded.int.module.cmdmod][INFO    ][22075] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-19 21:40:55,482 [salt.loaded.int.module.cmdmod][INFO    ][22075] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-12-19 21:40:55,535 [salt.loaded.int.module.cmdmod][INFO    ][22075] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-19 21:40:55,542 [salt.loaded.int.module.cmdmod][INFO    ][22075] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-19 21:40:55,550 [salt.loaded.int.module.cmdmod][INFO    ][22075] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-19 21:40:55,558 [salt.state       ][INFO    ][22075] {'keepalived': True}
2017-12-19 21:40:55,558 [salt.state       ][INFO    ][22075] Completed state [keepalived] at time 21:40:55.558434 duration_in_ms=108.537
2017-12-19 21:40:55,559 [salt.minion      ][INFO    ][22075] Returning information for job: 20171219214043474677
2017-12-19 21:43:03,664 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command pillar.get with jid 20171219214303652464
2017-12-19 21:43:03,685 [salt.minion      ][INFO    ][23570] Starting a new job with PID 23570
2017-12-19 21:43:03,693 [salt.minion      ][INFO    ][23570] Returning information for job: 20171219214303652464
2017-12-19 21:48:17,078 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command state.sls with jid 20171219214817066892
2017-12-19 21:48:17,093 [salt.minion      ][INFO    ][23667] Starting a new job with PID 23667
2017-12-19 21:48:19,520 [salt.state       ][INFO    ][23667] Loading fresh modules for state activity
2017-12-19 21:48:19,541 [salt.fileclient  ][INFO    ][23667] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-19 21:48:19,561 [salt.fileclient  ][INFO    ][23667] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-19 21:48:19,833 [salt.state       ][INFO    ][23667] Running state [attr] at time 21:48:19.832572
2017-12-19 21:48:19,833 [salt.state       ][INFO    ][23667] Executing state pkg.installed for attr
2017-12-19 21:48:19,833 [salt.loaded.int.module.cmdmod][INFO    ][23667] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:48:20,104 [salt.loaded.int.module.cmdmod][INFO    ][23667] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-19 21:48:22,020 [salt.loaded.int.module.cmdmod][INFO    ][23667] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-12-19 21:48:24,447 [salt.loaded.int.module.cmdmod][INFO    ][23667] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:48:24,472 [salt.state       ][INFO    ][23667] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-12-19 21:48:24,480 [salt.state       ][INFO    ][23667] Loading fresh modules for state activity
2017-12-19 21:48:24,492 [salt.state       ][INFO    ][23667] Completed state [attr] at time 21:48:24.491831 duration_in_ms=4659.258
2017-12-19 21:48:24,497 [salt.state       ][INFO    ][23667] Running state [glusterfs-server] at time 21:48:24.496767
2017-12-19 21:48:24,497 [salt.state       ][INFO    ][23667] Executing state pkg.installed for glusterfs-server
2017-12-19 21:48:24,683 [salt.loaded.int.module.cmdmod][INFO    ][23667] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-12-19 21:48:27,217 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command saltutil.find_job with jid 20171219214827157960
2017-12-19 21:48:27,231 [salt.minion      ][INFO    ][24542] Starting a new job with PID 24542
2017-12-19 21:48:27,243 [salt.minion      ][INFO    ][24542] Returning information for job: 20171219214827157960
2017-12-19 21:48:37,416 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command saltutil.find_job with jid 20171219214837404456
2017-12-19 21:48:37,431 [salt.minion      ][INFO    ][24549] Starting a new job with PID 24549
2017-12-19 21:48:37,443 [salt.minion      ][INFO    ][24549] Returning information for job: 20171219214837404456
2017-12-19 21:48:47,615 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command saltutil.find_job with jid 20171219214847603849
2017-12-19 21:48:47,629 [salt.minion      ][INFO    ][24592] Starting a new job with PID 24592
2017-12-19 21:48:47,641 [salt.minion      ][INFO    ][24592] Returning information for job: 20171219214847603849
2017-12-19 21:48:57,823 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command saltutil.find_job with jid 20171219214857811506
2017-12-19 21:48:57,837 [salt.minion      ][INFO    ][25887] Starting a new job with PID 25887
2017-12-19 21:48:57,849 [salt.minion      ][INFO    ][25887] Returning information for job: 20171219214857811506
2017-12-19 21:48:59,735 [salt.loaded.int.module.cmdmod][INFO    ][23667] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:48:59,761 [salt.state       ][INFO    ][23667] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.2'
'glusterfs-client' changed from 'absent' to '3.10.8-ubuntu1~xenial1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'glusterfs-common' changed from 'absent' to '3.10.8-ubuntu1~xenial1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'portmap' changed from 'absent' to '1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'
'nfs-client' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.10.8-ubuntu1~xenial1'

2017-12-19 21:48:59,768 [salt.state       ][INFO    ][23667] Loading fresh modules for state activity
2017-12-19 21:48:59,781 [salt.state       ][INFO    ][23667] Completed state [glusterfs-server] at time 21:48:59.780609 duration_in_ms=35283.84
2017-12-19 21:48:59,785 [salt.state       ][INFO    ][23667] Running state [bc] at time 21:48:59.785391
2017-12-19 21:48:59,786 [salt.state       ][INFO    ][23667] Executing state pkg.installed for bc
2017-12-19 21:49:00,044 [salt.loaded.int.module.cmdmod][INFO    ][23667] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-12-19 21:49:02,804 [salt.loaded.int.module.cmdmod][INFO    ][23667] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:49:02,831 [salt.state       ][INFO    ][23667] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-12-19 21:49:02,840 [salt.state       ][INFO    ][23667] Loading fresh modules for state activity
2017-12-19 21:49:02,853 [salt.state       ][INFO    ][23667] Completed state [bc] at time 21:49:02.853337 duration_in_ms=3067.946
2017-12-19 21:49:02,923 [salt.state       ][INFO    ][23667] Running state [glusterfs-server] at time 21:49:02.923339
2017-12-19 21:49:02,924 [salt.state       ][INFO    ][23667] Executing state service.running for glusterfs-server
2017-12-19 21:49:02,925 [salt.loaded.int.module.cmdmod][INFO    ][23667] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-19 21:49:02,934 [salt.loaded.int.module.cmdmod][INFO    ][23667] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-19 21:49:02,942 [salt.loaded.int.module.cmdmod][INFO    ][23667] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-19 21:49:02,951 [salt.state       ][INFO    ][23667] The service glusterfs-server is already running
2017-12-19 21:49:02,951 [salt.state       ][INFO    ][23667] Completed state [glusterfs-server] at time 21:49:02.951178 duration_in_ms=27.839
2017-12-19 21:49:02,953 [salt.state       ][INFO    ][23667] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:49:02.953132
2017-12-19 21:49:02,953 [salt.state       ][INFO    ][23667] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-19 21:49:02,967 [salt.state       ][INFO    ][23667] File changed:
New file
2017-12-19 21:49:02,968 [salt.state       ][INFO    ][23667] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:49:02.967630 duration_in_ms=14.498
2017-12-19 21:49:02,968 [salt.state       ][INFO    ][23667] Running state [/srv/glusterfs/glance] at time 21:49:02.967789
2017-12-19 21:49:02,968 [salt.state       ][INFO    ][23667] Executing state file.directory for /srv/glusterfs/glance
2017-12-19 21:49:02,969 [salt.state       ][INFO    ][23667] {'/srv/glusterfs/glance': 'New Dir'}
2017-12-19 21:49:02,969 [salt.state       ][INFO    ][23667] Completed state [/srv/glusterfs/glance] at time 21:49:02.968669 duration_in_ms=0.88
2017-12-19 21:49:02,969 [salt.state       ][INFO    ][23667] Running state [/srv/glusterfs/keystone-keys] at time 21:49:02.968821
2017-12-19 21:49:02,969 [salt.state       ][INFO    ][23667] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-19 21:49:02,969 [salt.state       ][INFO    ][23667] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-12-19 21:49:02,970 [salt.state       ][INFO    ][23667] Completed state [/srv/glusterfs/keystone-keys] at time 21:49:02.969507 duration_in_ms=0.685
2017-12-19 21:49:02,970 [salt.state       ][INFO    ][23667] Running state [/srv/glusterfs/nova_instances] at time 21:49:02.969657
2017-12-19 21:49:02,970 [salt.state       ][INFO    ][23667] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-19 21:49:02,970 [salt.state       ][INFO    ][23667] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-12-19 21:49:02,970 [salt.state       ][INFO    ][23667] Completed state [/srv/glusterfs/nova_instances] at time 21:49:02.970330 duration_in_ms=0.672
2017-12-19 21:49:02,971 [salt.state       ][INFO    ][23667] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:49:02.970482
2017-12-19 21:49:02,971 [salt.state       ][INFO    ][23667] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-19 21:49:02,971 [salt.state       ][INFO    ][23667] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-12-19 21:49:02,971 [salt.state       ][INFO    ][23667] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:49:02.971139 duration_in_ms=0.658
2017-12-19 21:49:02,972 [salt.minion      ][INFO    ][23667] Returning information for job: 20171219214817066892
2017-12-19 21:49:04,194 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command test.ping with jid 20171219214904181462
2017-12-19 21:49:04,208 [salt.minion      ][INFO    ][26519] Starting a new job with PID 26519
2017-12-19 21:49:04,234 [salt.minion      ][INFO    ][26519] Returning information for job: 20171219214904181462
2017-12-19 21:49:40,774 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command state.sls with jid 20171219214940762963
2017-12-19 21:49:40,787 [salt.minion      ][INFO    ][27153] Starting a new job with PID 27153
2017-12-19 21:49:42,206 [salt.state       ][INFO    ][27153] Loading fresh modules for state activity
2017-12-19 21:49:42,228 [salt.fileclient  ][INFO    ][27153] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-19 21:49:42,263 [salt.fileclient  ][INFO    ][27153] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-19 21:49:42,338 [salt.fileclient  ][INFO    ][27153] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-19 21:49:42,357 [salt.fileclient  ][INFO    ][27153] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-19 21:49:42,628 [salt.state       ][INFO    ][27153] Running state [attr] at time 21:49:42.627590
2017-12-19 21:49:42,628 [salt.state       ][INFO    ][27153] Executing state pkg.installed for attr
2017-12-19 21:49:42,628 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:49:42,884 [salt.state       ][INFO    ][27153] Package attr is already installed
2017-12-19 21:49:42,884 [salt.state       ][INFO    ][27153] Completed state [attr] at time 21:49:42.883789 duration_in_ms=256.198
2017-12-19 21:49:42,884 [salt.state       ][INFO    ][27153] Running state [glusterfs-server] at time 21:49:42.883991
2017-12-19 21:49:42,884 [salt.state       ][INFO    ][27153] Executing state pkg.installed for glusterfs-server
2017-12-19 21:49:42,887 [salt.state       ][INFO    ][27153] Package glusterfs-server is already installed
2017-12-19 21:49:42,887 [salt.state       ][INFO    ][27153] Completed state [glusterfs-server] at time 21:49:42.886908 duration_in_ms=2.918
2017-12-19 21:49:42,887 [salt.state       ][INFO    ][27153] Running state [bc] at time 21:49:42.887042
2017-12-19 21:49:42,887 [salt.state       ][INFO    ][27153] Executing state pkg.installed for bc
2017-12-19 21:49:42,890 [salt.state       ][INFO    ][27153] Package bc is already installed
2017-12-19 21:49:42,890 [salt.state       ][INFO    ][27153] Completed state [bc] at time 21:49:42.889788 duration_in_ms=2.745
2017-12-19 21:49:42,891 [salt.state       ][INFO    ][27153] Running state [glusterfs-server] at time 21:49:42.890576
2017-12-19 21:49:42,891 [salt.state       ][INFO    ][27153] Executing state service.running for glusterfs-server
2017-12-19 21:49:42,891 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-19 21:49:42,900 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-19 21:49:42,942 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-19 21:49:42,956 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-19 21:49:42,963 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-19 21:49:42,971 [salt.state       ][INFO    ][27153] The service glusterfs-server is already running
2017-12-19 21:49:42,971 [salt.state       ][INFO    ][27153] Completed state [glusterfs-server] at time 21:49:42.971062 duration_in_ms=80.484
2017-12-19 21:49:42,973 [salt.state       ][INFO    ][27153] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:49:42.972517
2017-12-19 21:49:42,973 [salt.state       ][INFO    ][27153] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-19 21:49:42,983 [salt.state       ][INFO    ][27153] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-19 21:49:42,983 [salt.state       ][INFO    ][27153] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:49:42.982902 duration_in_ms=10.385
2017-12-19 21:49:42,983 [salt.state       ][INFO    ][27153] Running state [/srv/glusterfs/glance] at time 21:49:42.983066
2017-12-19 21:49:42,983 [salt.state       ][INFO    ][27153] Executing state file.directory for /srv/glusterfs/glance
2017-12-19 21:49:42,984 [salt.state       ][INFO    ][27153] Directory /srv/glusterfs/glance is in the correct state
2017-12-19 21:49:42,984 [salt.state       ][INFO    ][27153] Completed state [/srv/glusterfs/glance] at time 21:49:42.983685 duration_in_ms=0.619
2017-12-19 21:49:42,984 [salt.state       ][INFO    ][27153] Running state [/srv/glusterfs/keystone-keys] at time 21:49:42.983839
2017-12-19 21:49:42,984 [salt.state       ][INFO    ][27153] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-19 21:49:42,984 [salt.state       ][INFO    ][27153] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-19 21:49:42,985 [salt.state       ][INFO    ][27153] Completed state [/srv/glusterfs/keystone-keys] at time 21:49:42.984483 duration_in_ms=0.643
2017-12-19 21:49:42,985 [salt.state       ][INFO    ][27153] Running state [/srv/glusterfs/nova_instances] at time 21:49:42.984641
2017-12-19 21:49:42,985 [salt.state       ][INFO    ][27153] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-19 21:49:42,985 [salt.state       ][INFO    ][27153] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-19 21:49:42,985 [salt.state       ][INFO    ][27153] Completed state [/srv/glusterfs/nova_instances] at time 21:49:42.985251 duration_in_ms=0.609
2017-12-19 21:49:42,985 [salt.state       ][INFO    ][27153] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:49:42.985396
2017-12-19 21:49:42,986 [salt.state       ][INFO    ][27153] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-19 21:49:42,986 [salt.state       ][INFO    ][27153] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-19 21:49:42,986 [salt.state       ][INFO    ][27153] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:49:42.985992 duration_in_ms=0.596
2017-12-19 21:49:43,084 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command ['git', '--version'] in directory '/root'
2017-12-19 21:49:43,127 [salt.state       ][INFO    ][27153] Running state [sleep 5] at time 21:49:43.126588
2017-12-19 21:49:43,127 [salt.state       ][INFO    ][27153] Executing state cmd.wait for sleep 5
2017-12-19 21:49:43,127 [salt.state       ][INFO    ][27153] No changes made for sleep 5
2017-12-19 21:49:43,127 [salt.state       ][INFO    ][27153] Completed state [sleep 5] at time 21:49:43.127136 duration_in_ms=0.549
2017-12-19 21:49:43,128 [salt.state       ][INFO    ][27153] Running state [10.167.4.141] at time 21:49:43.127525
2017-12-19 21:49:43,128 [salt.state       ][INFO    ][27153] Executing state glusterfs.peered for 10.167.4.141
2017-12-19 21:49:43,128 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:43,137 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:43,190 [salt.state       ][INFO    ][27153] Host 10.167.4.141 already peered
2017-12-19 21:49:43,190 [salt.state       ][INFO    ][27153] Completed state [10.167.4.141] at time 21:49:43.190026 duration_in_ms=62.501
2017-12-19 21:49:43,192 [salt.state       ][INFO    ][27153] Running state [10.167.4.142] at time 21:49:43.192077
2017-12-19 21:49:43,192 [salt.state       ][INFO    ][27153] Executing state glusterfs.peered for 10.167.4.142
2017-12-19 21:49:43,193 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:43,201 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:43,252 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:43,261 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:43,313 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:43,320 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:43,370 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:43,378 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:43,428 [salt.state       ][INFO    ][27153] Peering with localhost is not needed
2017-12-19 21:49:43,429 [salt.state       ][INFO    ][27153] Completed state [10.167.4.142] at time 21:49:43.428560 duration_in_ms=236.483
2017-12-19 21:49:43,431 [salt.state       ][INFO    ][27153] Running state [10.167.4.143] at time 21:49:43.430769
2017-12-19 21:49:43,431 [salt.state       ][INFO    ][27153] Executing state glusterfs.peered for 10.167.4.143
2017-12-19 21:49:43,431 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:43,440 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:43,491 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:43,499 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:43,554 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:43,563 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:43,625 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:43,634 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:43,684 [salt.state       ][INFO    ][27153] {'new': {'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': ['10.167.4.143'], '10.167.4.141': []}, 'old': {'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': [], '10.167.4.141': []}}
2017-12-19 21:49:43,684 [salt.state       ][INFO    ][27153] Completed state [10.167.4.143] at time 21:49:43.684433 duration_in_ms=253.663
2017-12-19 21:49:43,685 [salt.state       ][INFO    ][27153] Running state [glance] at time 21:49:43.685222
2017-12-19 21:49:43,685 [salt.state       ][INFO    ][27153] Executing state glusterfs.created for glance
2017-12-19 21:49:43,686 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:43,694 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:43,745 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:43,753 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:43,807 [salt.state       ][INFO    ][27153] Volume glance already exists and is started.
2017-12-19 21:49:43,807 [salt.state       ][INFO    ][27153] Completed state [glance] at time 21:49:43.807109 duration_in_ms=121.887
2017-12-19 21:49:43,810 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:43.810218
2017-12-19 21:49:43,810 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 21:49:43,811 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:43,863 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:43,863 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:43.863248 duration_in_ms=53.029
2017-12-19 21:49:43,864 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:49:43.863696
2017-12-19 21:49:43,864 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-19 21:49:43,864 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 21:49:43,915 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:43,916 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:49:43.915542 duration_in_ms=51.845
2017-12-19 21:49:43,916 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:49:43.916017
2017-12-19 21:49:43,916 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-19 21:49:43,917 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 21:49:43,967 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:43,968 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:49:43.967653 duration_in_ms=51.636
2017-12-19 21:49:43,968 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:43.968117
2017-12-19 21:49:43,968 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 21:49:43,969 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 21:49:44,018 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:44,018 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:44.018456 duration_in_ms=50.339
2017-12-19 21:49:44,019 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:44.018915
2017-12-19 21:49:44,019 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 21:49:44,020 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:44,070 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:44,070 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:44.070236 duration_in_ms=51.32
2017-12-19 21:49:44,071 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:49:44.070674
2017-12-19 21:49:44,071 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-19 21:49:44,071 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 21:49:44,120 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:44,121 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:49:44.120589 duration_in_ms=49.915
2017-12-19 21:49:44,122 [salt.state       ][INFO    ][27153] Running state [glance] at time 21:49:44.121668
2017-12-19 21:49:44,122 [salt.state       ][INFO    ][27153] Executing state glusterfs.started for glance
2017-12-19 21:49:44,122 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:44,130 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:44,181 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:44,190 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:44,244 [salt.state       ][INFO    ][27153] Volume glance is already started
2017-12-19 21:49:44,244 [salt.state       ][INFO    ][27153] Completed state [glance] at time 21:49:44.244136 duration_in_ms=122.468
2017-12-19 21:49:44,245 [salt.state       ][INFO    ][27153] Running state [keystone-keys] at time 21:49:44.244979
2017-12-19 21:49:44,245 [salt.state       ][INFO    ][27153] Executing state glusterfs.created for keystone-keys
2017-12-19 21:49:44,246 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:44,254 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:44,305 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:44,314 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:44,368 [salt.state       ][INFO    ][27153] Volume keystone-keys already exists and is started.
2017-12-19 21:49:44,368 [salt.state       ][INFO    ][27153] Completed state [keystone-keys] at time 21:49:44.368071 duration_in_ms=123.091
2017-12-19 21:49:44,372 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:49:44.371486
2017-12-19 21:49:44,372 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-19 21:49:44,372 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 21:49:44,422 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:44,423 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:49:44.422578 duration_in_ms=51.092
2017-12-19 21:49:44,423 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:44.423025
2017-12-19 21:49:44,423 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 21:49:44,424 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:44,474 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:44,474 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:44.474004 duration_in_ms=50.979
2017-12-19 21:49:44,475 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:44.474477
2017-12-19 21:49:44,475 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 21:49:44,475 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 21:49:44,526 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:44,526 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:44.526245 duration_in_ms=51.768
2017-12-19 21:49:44,527 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:44.526722
2017-12-19 21:49:44,527 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 21:49:44,527 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:44,582 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:44,582 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:44.582401 duration_in_ms=55.679
2017-12-19 21:49:44,583 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:49:44.582858
2017-12-19 21:49:44,583 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-19 21:49:44,583 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 21:49:44,634 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:44,634 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:49:44.633952 duration_in_ms=51.094
2017-12-19 21:49:44,634 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:49:44.634428
2017-12-19 21:49:44,635 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-19 21:49:44,635 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 21:49:44,691 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:44,692 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:49:44.691632 duration_in_ms=57.203
2017-12-19 21:49:44,693 [salt.state       ][INFO    ][27153] Running state [keystone-keys] at time 21:49:44.692754
2017-12-19 21:49:44,693 [salt.state       ][INFO    ][27153] Executing state glusterfs.started for keystone-keys
2017-12-19 21:49:44,693 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:44,701 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:44,752 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:44,761 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:44,816 [salt.state       ][INFO    ][27153] Volume keystone-keys is already started
2017-12-19 21:49:44,817 [salt.state       ][INFO    ][27153] Completed state [keystone-keys] at time 21:49:44.816637 duration_in_ms=123.881
2017-12-19 21:49:44,818 [salt.state       ][INFO    ][27153] Running state [nova_instances] at time 21:49:44.817504
2017-12-19 21:49:44,818 [salt.state       ][INFO    ][27153] Executing state glusterfs.created for nova_instances
2017-12-19 21:49:44,818 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:44,826 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:44,877 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:44,887 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:44,943 [salt.state       ][INFO    ][27153] Volume nova_instances already exists and is started.
2017-12-19 21:49:44,944 [salt.state       ][INFO    ][27153] Completed state [nova_instances] at time 21:49:44.943599 duration_in_ms=126.094
2017-12-19 21:49:44,948 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:44.947862
2017-12-19 21:49:44,948 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 21:49:44,949 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:45,002 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:45,002 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:45.002230 duration_in_ms=54.368
2017-12-19 21:49:45,003 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 21:49:45.002715
2017-12-19 21:49:45,003 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-19 21:49:45,003 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 21:49:45,056 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:45,056 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 21:49:45.055818 duration_in_ms=53.102
2017-12-19 21:49:45,056 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 21:49:45.056348
2017-12-19 21:49:45,057 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-19 21:49:45,057 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 21:49:45,114 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:45,114 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 21:49:45.114449 duration_in_ms=58.101
2017-12-19 21:49:45,115 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:45.114943
2017-12-19 21:49:45,115 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 21:49:45,116 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 21:49:45,168 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:45,168 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:45.167875 duration_in_ms=52.931
2017-12-19 21:49:45,168 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 21:49:45.168416
2017-12-19 21:49:45,169 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-19 21:49:45,169 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 21:49:45,222 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:45,222 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 21:49:45.221908 duration_in_ms=53.491
2017-12-19 21:49:45,223 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:45.222463
2017-12-19 21:49:45,223 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 21:49:45,223 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:45,278 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:45,279 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:45.278629 duration_in_ms=56.165
2017-12-19 21:49:45,280 [salt.state       ][INFO    ][27153] Running state [nova_instances] at time 21:49:45.279706
2017-12-19 21:49:45,280 [salt.state       ][INFO    ][27153] Executing state glusterfs.started for nova_instances
2017-12-19 21:49:45,280 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:45,289 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:45,343 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:45,351 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:45,407 [salt.state       ][INFO    ][27153] Volume nova_instances is already started
2017-12-19 21:49:45,407 [salt.state       ][INFO    ][27153] Completed state [nova_instances] at time 21:49:45.407324 duration_in_ms=127.618
2017-12-19 21:49:45,408 [salt.state       ][INFO    ][27153] Running state [keystone-credential-keys] at time 21:49:45.408271
2017-12-19 21:49:45,409 [salt.state       ][INFO    ][27153] Executing state glusterfs.created for keystone-credential-keys
2017-12-19 21:49:45,409 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:45,417 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:45,468 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:45,477 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:45,532 [salt.state       ][INFO    ][27153] Volume keystone-credential-keys already exists and is started.
2017-12-19 21:49:45,532 [salt.state       ][INFO    ][27153] Completed state [keystone-credential-keys] at time 21:49:45.532009 duration_in_ms=123.737
2017-12-19 21:49:45,536 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:49:45.535729
2017-12-19 21:49:45,536 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-19 21:49:45,537 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 21:49:45,591 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:45,591 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:49:45.591347 duration_in_ms=55.617
2017-12-19 21:49:45,592 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:45.591837
2017-12-19 21:49:45,592 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 21:49:45,593 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 21:49:45,646 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:45,646 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:45.645668 duration_in_ms=53.83
2017-12-19 21:49:45,646 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:45.646122
2017-12-19 21:49:45,646 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 21:49:45,647 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:45,699 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:45,699 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:45.698995 duration_in_ms=52.873
2017-12-19 21:49:45,700 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:49:45.699475
2017-12-19 21:49:45,700 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-19 21:49:45,700 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 21:49:45,752 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:45,753 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:49:45.752615 duration_in_ms=53.138
2017-12-19 21:49:45,753 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:45.753098
2017-12-19 21:49:45,753 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 21:49:45,754 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:45,805 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:45,806 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:45.805552 duration_in_ms=52.453
2017-12-19 21:49:45,806 [salt.state       ][INFO    ][27153] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:49:45.806026
2017-12-19 21:49:45,806 [salt.state       ][INFO    ][27153] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-19 21:49:45,807 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 21:49:45,859 [salt.state       ][INFO    ][27153] unless execution succeeded
2017-12-19 21:49:45,859 [salt.state       ][INFO    ][27153] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:49:45.858805 duration_in_ms=52.778
2017-12-19 21:49:45,860 [salt.state       ][INFO    ][27153] Running state [keystone-credential-keys] at time 21:49:45.859899
2017-12-19 21:49:45,860 [salt.state       ][INFO    ][27153] Executing state glusterfs.started for keystone-credential-keys
2017-12-19 21:49:45,861 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:45,868 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:45,921 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:45,929 [salt.loaded.int.module.cmdmod][INFO    ][27153] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:45,983 [salt.state       ][INFO    ][27153] Volume keystone-credential-keys is already started
2017-12-19 21:49:45,983 [salt.state       ][INFO    ][27153] Completed state [keystone-credential-keys] at time 21:49:45.983226 duration_in_ms=123.327
2017-12-19 21:49:45,986 [salt.minion      ][INFO    ][27153] Returning information for job: 20171219214940762963
2017-12-19 21:49:51,442 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command test.ping with jid 20171219214951430253
2017-12-19 21:49:51,455 [salt.minion      ][INFO    ][27713] Starting a new job with PID 27713
2017-12-19 21:49:51,481 [salt.minion      ][INFO    ][27713] Returning information for job: 20171219214951430253
2017-12-19 21:49:51,880 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command cmd.run with jid 20171219214951869291
2017-12-19 21:49:51,894 [salt.minion      ][INFO    ][27718] Starting a new job with PID 27718
2017-12-19 21:49:51,899 [salt.loaded.int.module.cmdmod][INFO    ][27718] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-19 21:49:52,020 [salt.minion      ][INFO    ][27718] Returning information for job: 20171219214951869291
2017-12-19 22:22:53,645 [salt.utils.schedule][INFO    ][21335] Running scheduled job: __mine_interval
2017-12-19 22:56:39,115 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command test.ping with jid 20171219225639106542
2017-12-19 22:56:39,133 [salt.minion      ][INFO    ][28591] Starting a new job with PID 28591
2017-12-19 22:56:39,167 [salt.minion      ][INFO    ][28591] Returning information for job: 20171219225639106542
2017-12-19 22:56:55,147 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command state.sls with jid 20171219225655132825
2017-12-19 22:56:55,160 [salt.minion      ][INFO    ][28621] Starting a new job with PID 28621
2017-12-19 22:56:55,682 [salt.state       ][INFO    ][28621] Loading fresh modules for state activity
2017-12-19 22:56:55,707 [salt.fileclient  ][INFO    ][28621] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-19 22:56:55,726 [salt.fileclient  ][INFO    ][28621] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-19 22:56:55,749 [salt.fileclient  ][INFO    ][28621] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 22:56:56,269 [salt.state       ][INFO    ][28621] Running state [lsof] at time 22:56:56.268983
2017-12-19 22:56:56,269 [salt.state       ][INFO    ][28621] Executing state pkg.installed for lsof
2017-12-19 22:56:56,270 [salt.loaded.int.module.cmdmod][INFO    ][28621] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 22:56:56,711 [salt.state       ][INFO    ][28621] Package lsof is already installed
2017-12-19 22:56:56,711 [salt.state       ][INFO    ][28621] Completed state [lsof] at time 22:56:56.710836 duration_in_ms=441.853
2017-12-19 22:56:56,711 [salt.state       ][INFO    ][28621] Running state [keepalived] at time 22:56:56.711052
2017-12-19 22:56:56,711 [salt.state       ][INFO    ][28621] Executing state pkg.installed for keepalived
2017-12-19 22:56:56,714 [salt.state       ][INFO    ][28621] Package keepalived is already installed
2017-12-19 22:56:56,714 [salt.state       ][INFO    ][28621] Completed state [keepalived] at time 22:56:56.713947 duration_in_ms=2.895
2017-12-19 22:56:56,715 [salt.state       ][INFO    ][28621] Running state [/etc/keepalived/keepalived.conf] at time 22:56:56.715421
2017-12-19 22:56:56,716 [salt.state       ][INFO    ][28621] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-19 22:56:56,742 [salt.fileclient  ][INFO    ][28621] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-19 22:56:56,773 [salt.fileclient  ][INFO    ][28621] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 22:56:56,778 [salt.state       ][INFO    ][28621] File /etc/keepalived/keepalived.conf is in the correct state
2017-12-19 22:56:56,778 [salt.state       ][INFO    ][28621] Completed state [/etc/keepalived/keepalived.conf] at time 22:56:56.777782 duration_in_ms=62.362
2017-12-19 22:56:56,785 [salt.state       ][INFO    ][28621] Running state [keepalived] at time 22:56:56.784585
2017-12-19 22:56:56,785 [salt.state       ][INFO    ][28621] Executing state service.running for keepalived
2017-12-19 22:56:56,785 [salt.loaded.int.module.cmdmod][INFO    ][28621] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-19 22:56:56,810 [salt.loaded.int.module.cmdmod][INFO    ][28621] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-19 22:56:56,818 [salt.loaded.int.module.cmdmod][INFO    ][28621] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-19 22:56:56,826 [salt.state       ][INFO    ][28621] The service keepalived is already running
2017-12-19 22:56:56,826 [salt.state       ][INFO    ][28621] Completed state [keepalived] at time 22:56:56.826063 duration_in_ms=41.478
2017-12-19 22:56:56,827 [salt.minion      ][INFO    ][28621] Returning information for job: 20171219225655132825
2017-12-19 22:57:14,137 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command pillar.get with jid 20171219225714123318
2017-12-19 22:57:14,161 [salt.minion      ][INFO    ][28647] Starting a new job with PID 28647
2017-12-19 22:57:14,167 [salt.minion      ][INFO    ][28647] Returning information for job: 20171219225714123318
2017-12-19 22:57:52,090 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command state.sls with jid 20171219225752076704
2017-12-19 22:57:52,105 [salt.minion      ][INFO    ][28652] Starting a new job with PID 28652
2017-12-19 22:57:53,964 [salt.state       ][INFO    ][28652] Loading fresh modules for state activity
2017-12-19 22:57:53,986 [salt.fileclient  ][INFO    ][28652] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-19 22:57:54,009 [salt.fileclient  ][INFO    ][28652] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-19 22:57:54,287 [salt.state       ][INFO    ][28652] Running state [attr] at time 22:57:54.286580
2017-12-19 22:57:54,287 [salt.state       ][INFO    ][28652] Executing state pkg.installed for attr
2017-12-19 22:57:54,287 [salt.loaded.int.module.cmdmod][INFO    ][28652] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 22:57:54,586 [salt.state       ][INFO    ][28652] Package attr is already installed
2017-12-19 22:57:54,586 [salt.state       ][INFO    ][28652] Completed state [attr] at time 22:57:54.586440 duration_in_ms=299.861
2017-12-19 22:57:54,587 [salt.state       ][INFO    ][28652] Running state [glusterfs-server] at time 22:57:54.586641
2017-12-19 22:57:54,587 [salt.state       ][INFO    ][28652] Executing state pkg.installed for glusterfs-server
2017-12-19 22:57:54,589 [salt.state       ][INFO    ][28652] Package glusterfs-server is already installed
2017-12-19 22:57:54,590 [salt.state       ][INFO    ][28652] Completed state [glusterfs-server] at time 22:57:54.589523 duration_in_ms=2.881
2017-12-19 22:57:54,590 [salt.state       ][INFO    ][28652] Running state [bc] at time 22:57:54.589665
2017-12-19 22:57:54,590 [salt.state       ][INFO    ][28652] Executing state pkg.installed for bc
2017-12-19 22:57:54,592 [salt.state       ][INFO    ][28652] Package bc is already installed
2017-12-19 22:57:54,592 [salt.state       ][INFO    ][28652] Completed state [bc] at time 22:57:54.592468 duration_in_ms=2.804
2017-12-19 22:57:54,593 [salt.state       ][INFO    ][28652] Running state [glusterfs-server] at time 22:57:54.593133
2017-12-19 22:57:54,593 [salt.state       ][INFO    ][28652] Executing state service.running for glusterfs-server
2017-12-19 22:57:54,594 [salt.loaded.int.module.cmdmod][INFO    ][28652] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-19 22:57:54,612 [salt.loaded.int.module.cmdmod][INFO    ][28652] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-19 22:57:54,620 [salt.loaded.int.module.cmdmod][INFO    ][28652] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-19 22:57:54,631 [salt.state       ][INFO    ][28652] The service glusterfs-server is already running
2017-12-19 22:57:54,631 [salt.state       ][INFO    ][28652] Completed state [glusterfs-server] at time 22:57:54.630797 duration_in_ms=37.663
2017-12-19 22:57:54,632 [salt.state       ][INFO    ][28652] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:57:54.632180
2017-12-19 22:57:54,632 [salt.state       ][INFO    ][28652] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-19 22:57:54,643 [salt.state       ][INFO    ][28652] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-19 22:57:54,643 [salt.state       ][INFO    ][28652] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:57:54.643262 duration_in_ms=11.082
2017-12-19 22:57:54,643 [salt.state       ][INFO    ][28652] Running state [/srv/glusterfs/glance] at time 22:57:54.643449
2017-12-19 22:57:54,644 [salt.state       ][INFO    ][28652] Executing state file.directory for /srv/glusterfs/glance
2017-12-19 22:57:54,644 [salt.state       ][INFO    ][28652] Directory /srv/glusterfs/glance is in the correct state
2017-12-19 22:57:54,644 [salt.state       ][INFO    ][28652] Completed state [/srv/glusterfs/glance] at time 22:57:54.644129 duration_in_ms=0.68
2017-12-19 22:57:54,644 [salt.state       ][INFO    ][28652] Running state [/srv/glusterfs/keystone-keys] at time 22:57:54.644285
2017-12-19 22:57:54,644 [salt.state       ][INFO    ][28652] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-19 22:57:54,645 [salt.state       ][INFO    ][28652] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-19 22:57:54,645 [salt.state       ][INFO    ][28652] Completed state [/srv/glusterfs/keystone-keys] at time 22:57:54.644923 duration_in_ms=0.637
2017-12-19 22:57:54,645 [salt.state       ][INFO    ][28652] Running state [/srv/glusterfs/nova_instances] at time 22:57:54.645081
2017-12-19 22:57:54,645 [salt.state       ][INFO    ][28652] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-19 22:57:54,646 [salt.state       ][INFO    ][28652] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-19 22:57:54,646 [salt.state       ][INFO    ][28652] Completed state [/srv/glusterfs/nova_instances] at time 22:57:54.645700 duration_in_ms=0.62
2017-12-19 22:57:54,646 [salt.state       ][INFO    ][28652] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:57:54.645849
2017-12-19 22:57:54,646 [salt.state       ][INFO    ][28652] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-19 22:57:54,646 [salt.state       ][INFO    ][28652] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-19 22:57:54,646 [salt.state       ][INFO    ][28652] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:57:54.646456 duration_in_ms=0.606
2017-12-19 22:57:54,647 [salt.minion      ][INFO    ][28652] Returning information for job: 20171219225752076704
2017-12-19 22:57:56,359 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command test.ping with jid 20171219225756350127
2017-12-19 22:57:56,375 [salt.minion      ][INFO    ][28675] Starting a new job with PID 28675
2017-12-19 22:57:56,403 [salt.minion      ][INFO    ][28675] Returning information for job: 20171219225756350127
2017-12-19 22:58:00,935 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command state.sls with jid 20171219225800921520
2017-12-19 22:58:00,950 [salt.minion      ][INFO    ][28680] Starting a new job with PID 28680
2017-12-19 22:58:01,360 [salt.state       ][INFO    ][28680] Loading fresh modules for state activity
2017-12-19 22:58:01,380 [salt.fileclient  ][INFO    ][28680] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-19 22:58:01,414 [salt.fileclient  ][INFO    ][28680] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-19 22:58:01,484 [salt.fileclient  ][INFO    ][28680] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-19 22:58:01,504 [salt.fileclient  ][INFO    ][28680] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-19 22:58:01,770 [salt.state       ][INFO    ][28680] Running state [attr] at time 22:58:01.769834
2017-12-19 22:58:01,770 [salt.state       ][INFO    ][28680] Executing state pkg.installed for attr
2017-12-19 22:58:01,770 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 22:58:02,088 [salt.state       ][INFO    ][28680] Package attr is already installed
2017-12-19 22:58:02,088 [salt.state       ][INFO    ][28680] Completed state [attr] at time 22:58:02.088331 duration_in_ms=318.496
2017-12-19 22:58:02,089 [salt.state       ][INFO    ][28680] Running state [glusterfs-server] at time 22:58:02.088607
2017-12-19 22:58:02,089 [salt.state       ][INFO    ][28680] Executing state pkg.installed for glusterfs-server
2017-12-19 22:58:02,092 [salt.state       ][INFO    ][28680] Package glusterfs-server is already installed
2017-12-19 22:58:02,092 [salt.state       ][INFO    ][28680] Completed state [glusterfs-server] at time 22:58:02.091670 duration_in_ms=3.063
2017-12-19 22:58:02,092 [salt.state       ][INFO    ][28680] Running state [bc] at time 22:58:02.091874
2017-12-19 22:58:02,092 [salt.state       ][INFO    ][28680] Executing state pkg.installed for bc
2017-12-19 22:58:02,095 [salt.state       ][INFO    ][28680] Package bc is already installed
2017-12-19 22:58:02,095 [salt.state       ][INFO    ][28680] Completed state [bc] at time 22:58:02.094856 duration_in_ms=2.982
2017-12-19 22:58:02,096 [salt.state       ][INFO    ][28680] Running state [glusterfs-server] at time 22:58:02.095722
2017-12-19 22:58:02,096 [salt.state       ][INFO    ][28680] Executing state service.running for glusterfs-server
2017-12-19 22:58:02,096 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-19 22:58:02,114 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-19 22:58:02,123 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-19 22:58:02,134 [salt.state       ][INFO    ][28680] The service glusterfs-server is already running
2017-12-19 22:58:02,134 [salt.state       ][INFO    ][28680] Completed state [glusterfs-server] at time 22:58:02.134350 duration_in_ms=38.627
2017-12-19 22:58:02,136 [salt.state       ][INFO    ][28680] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:58:02.135662
2017-12-19 22:58:02,136 [salt.state       ][INFO    ][28680] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-19 22:58:02,143 [salt.state       ][INFO    ][28680] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-19 22:58:02,144 [salt.state       ][INFO    ][28680] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:58:02.143580 duration_in_ms=7.918
2017-12-19 22:58:02,144 [salt.state       ][INFO    ][28680] Running state [/srv/glusterfs/glance] at time 22:58:02.143800
2017-12-19 22:58:02,144 [salt.state       ][INFO    ][28680] Executing state file.directory for /srv/glusterfs/glance
2017-12-19 22:58:02,144 [salt.state       ][INFO    ][28680] Directory /srv/glusterfs/glance is in the correct state
2017-12-19 22:58:02,145 [salt.state       ][INFO    ][28680] Completed state [/srv/glusterfs/glance] at time 22:58:02.144588 duration_in_ms=0.788
2017-12-19 22:58:02,145 [salt.state       ][INFO    ][28680] Running state [/srv/glusterfs/keystone-keys] at time 22:58:02.144791
2017-12-19 22:58:02,145 [salt.state       ][INFO    ][28680] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-19 22:58:02,145 [salt.state       ][INFO    ][28680] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-19 22:58:02,146 [salt.state       ][INFO    ][28680] Completed state [/srv/glusterfs/keystone-keys] at time 22:58:02.145527 duration_in_ms=0.735
2017-12-19 22:58:02,146 [salt.state       ][INFO    ][28680] Running state [/srv/glusterfs/nova_instances] at time 22:58:02.145739
2017-12-19 22:58:02,146 [salt.state       ][INFO    ][28680] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-19 22:58:02,146 [salt.state       ][INFO    ][28680] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-19 22:58:02,147 [salt.state       ][INFO    ][28680] Completed state [/srv/glusterfs/nova_instances] at time 22:58:02.146488 duration_in_ms=0.749
2017-12-19 22:58:02,147 [salt.state       ][INFO    ][28680] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:58:02.146689
2017-12-19 22:58:02,147 [salt.state       ][INFO    ][28680] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-19 22:58:02,147 [salt.state       ][INFO    ][28680] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-19 22:58:02,147 [salt.state       ][INFO    ][28680] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:58:02.147447 duration_in_ms=0.758
2017-12-19 22:58:02,323 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command ['git', '--version'] in directory '/root'
2017-12-19 22:58:02,414 [salt.state       ][INFO    ][28680] Running state [sleep 5] at time 22:58:02.413829
2017-12-19 22:58:02,414 [salt.state       ][INFO    ][28680] Executing state cmd.wait for sleep 5
2017-12-19 22:58:02,414 [salt.state       ][INFO    ][28680] No changes made for sleep 5
2017-12-19 22:58:02,415 [salt.state       ][INFO    ][28680] Completed state [sleep 5] at time 22:58:02.414593 duration_in_ms=0.764
2017-12-19 22:58:02,415 [salt.state       ][INFO    ][28680] Running state [10.167.4.141] at time 22:58:02.415070
2017-12-19 22:58:02,415 [salt.state       ][INFO    ][28680] Executing state glusterfs.peered for 10.167.4.141
2017-12-19 22:58:02,416 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:02,445 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:02,526 [salt.state       ][INFO    ][28680] Host 10.167.4.141 already peered
2017-12-19 22:58:02,527 [salt.state       ][INFO    ][28680] Completed state [10.167.4.141] at time 22:58:02.526471 duration_in_ms=111.401
2017-12-19 22:58:02,529 [salt.state       ][INFO    ][28680] Running state [10.167.4.142] at time 22:58:02.528769
2017-12-19 22:58:02,529 [salt.state       ][INFO    ][28680] Executing state glusterfs.peered for 10.167.4.142
2017-12-19 22:58:02,529 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:02,540 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:02,596 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:02,606 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:02,664 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:02,674 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:02,730 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:02,740 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:02,798 [salt.state       ][INFO    ][28680] Peering with localhost is not needed
2017-12-19 22:58:02,799 [salt.state       ][INFO    ][28680] Completed state [10.167.4.142] at time 22:58:02.798646 duration_in_ms=269.876
2017-12-19 22:58:02,801 [salt.state       ][INFO    ][28680] Running state [10.167.4.143] at time 22:58:02.800922
2017-12-19 22:58:02,801 [salt.state       ][INFO    ][28680] Executing state glusterfs.peered for 10.167.4.143
2017-12-19 22:58:02,802 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:02,812 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:02,870 [salt.state       ][INFO    ][28680] Host 10.167.4.143 already peered
2017-12-19 22:58:02,870 [salt.state       ][INFO    ][28680] Completed state [10.167.4.143] at time 22:58:02.869809 duration_in_ms=68.886
2017-12-19 22:58:02,871 [salt.state       ][INFO    ][28680] Running state [glance] at time 22:58:02.870581
2017-12-19 22:58:02,871 [salt.state       ][INFO    ][28680] Executing state glusterfs.created for glance
2017-12-19 22:58:02,871 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:02,881 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:02,935 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:02,944 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:03,001 [salt.state       ][INFO    ][28680] Volume glance already exists and is started.
2017-12-19 22:58:03,002 [salt.state       ][INFO    ][28680] Completed state [glance] at time 22:58:03.001570 duration_in_ms=130.987
2017-12-19 22:58:03,005 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:58:03.004743
2017-12-19 22:58:03,005 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 22:58:03,005 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 22:58:03,058 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:03,058 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:58:03.058007 duration_in_ms=53.264
2017-12-19 22:58:03,058 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:58:03.058464
2017-12-19 22:58:03,059 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-19 22:58:03,059 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 22:58:03,110 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:03,110 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:58:03.110011 duration_in_ms=51.547
2017-12-19 22:58:03,111 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:58:03.110480
2017-12-19 22:58:03,111 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-19 22:58:03,111 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 22:58:03,164 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:03,164 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:58:03.163969 duration_in_ms=53.488
2017-12-19 22:58:03,164 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 22:58:03.164468
2017-12-19 22:58:03,165 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 22:58:03,165 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 22:58:03,215 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:03,215 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 22:58:03.215266 duration_in_ms=50.798
2017-12-19 22:58:03,216 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:58:03.215709
2017-12-19 22:58:03,216 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 22:58:03,216 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 22:58:03,268 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:03,268 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:58:03.267919 duration_in_ms=52.21
2017-12-19 22:58:03,268 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:58:03.268345
2017-12-19 22:58:03,269 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-19 22:58:03,269 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 22:58:03,320 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:03,320 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:58:03.320075 duration_in_ms=51.73
2017-12-19 22:58:03,321 [salt.state       ][INFO    ][28680] Running state [glance] at time 22:58:03.321202
2017-12-19 22:58:03,321 [salt.state       ][INFO    ][28680] Executing state glusterfs.started for glance
2017-12-19 22:58:03,322 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:03,330 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:03,380 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:03,388 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:03,443 [salt.state       ][INFO    ][28680] Volume glance is already started
2017-12-19 22:58:03,444 [salt.state       ][INFO    ][28680] Completed state [glance] at time 22:58:03.443620 duration_in_ms=122.417
2017-12-19 22:58:03,445 [salt.state       ][INFO    ][28680] Running state [keystone-keys] at time 22:58:03.444523
2017-12-19 22:58:03,445 [salt.state       ][INFO    ][28680] Executing state glusterfs.created for keystone-keys
2017-12-19 22:58:03,445 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:03,455 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:03,507 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:03,517 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:03,571 [salt.state       ][INFO    ][28680] Volume keystone-keys already exists and is started.
2017-12-19 22:58:03,571 [salt.state       ][INFO    ][28680] Completed state [keystone-keys] at time 22:58:03.570939 duration_in_ms=126.415
2017-12-19 22:58:03,574 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:58:03.574305
2017-12-19 22:58:03,575 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-19 22:58:03,575 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 22:58:03,627 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:03,631 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:58:03.630750 duration_in_ms=56.443
2017-12-19 22:58:03,631 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:58:03.631321
2017-12-19 22:58:03,632 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 22:58:03,632 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 22:58:03,683 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:03,683 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:58:03.683119 duration_in_ms=51.797
2017-12-19 22:58:03,684 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:58:03.683618
2017-12-19 22:58:03,684 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 22:58:03,684 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 22:58:03,739 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:03,739 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:58:03.738985 duration_in_ms=55.367
2017-12-19 22:58:03,739 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:58:03.739447
2017-12-19 22:58:03,740 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 22:58:03,740 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 22:58:03,792 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:03,792 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:58:03.792047 duration_in_ms=52.6
2017-12-19 22:58:03,793 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:58:03.792535
2017-12-19 22:58:03,793 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-19 22:58:03,793 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 22:58:03,845 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:03,845 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:58:03.844833 duration_in_ms=52.298
2017-12-19 22:58:03,845 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:58:03.845300
2017-12-19 22:58:03,846 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-19 22:58:03,846 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 22:58:03,897 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:03,897 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:58:03.897285 duration_in_ms=51.985
2017-12-19 22:58:03,898 [salt.state       ][INFO    ][28680] Running state [keystone-keys] at time 22:58:03.898364
2017-12-19 22:58:03,899 [salt.state       ][INFO    ][28680] Executing state glusterfs.started for keystone-keys
2017-12-19 22:58:03,899 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:03,908 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:03,961 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:03,970 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:04,023 [salt.state       ][INFO    ][28680] Volume keystone-keys is already started
2017-12-19 22:58:04,023 [salt.state       ][INFO    ][28680] Completed state [keystone-keys] at time 22:58:04.023395 duration_in_ms=125.03
2017-12-19 22:58:04,024 [salt.state       ][INFO    ][28680] Running state [nova_instances] at time 22:58:04.024224
2017-12-19 22:58:04,024 [salt.state       ][INFO    ][28680] Executing state glusterfs.created for nova_instances
2017-12-19 22:58:04,025 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:04,034 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:04,085 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:04,095 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:04,149 [salt.state       ][INFO    ][28680] Volume nova_instances already exists and is started.
2017-12-19 22:58:04,150 [salt.state       ][INFO    ][28680] Completed state [nova_instances] at time 22:58:04.149705 duration_in_ms=125.48
2017-12-19 22:58:04,155 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:58:04.154923
2017-12-19 22:58:04,156 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 22:58:04,157 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 22:58:04,209 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:04,210 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:58:04.209481 duration_in_ms=54.564
2017-12-19 22:58:04,210 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 22:58:04.210020
2017-12-19 22:58:04,210 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-19 22:58:04,211 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 22:58:04,262 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:04,263 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 22:58:04.262556 duration_in_ms=52.536
2017-12-19 22:58:04,263 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 22:58:04.263069
2017-12-19 22:58:04,263 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-19 22:58:04,264 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 22:58:04,313 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:04,313 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 22:58:04.313255 duration_in_ms=50.186
2017-12-19 22:58:04,314 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 22:58:04.313751
2017-12-19 22:58:04,314 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 22:58:04,314 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 22:58:04,367 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:04,368 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 22:58:04.367809 duration_in_ms=54.058
2017-12-19 22:58:04,368 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 22:58:04.368276
2017-12-19 22:58:04,369 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-19 22:58:04,369 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 22:58:04,421 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:04,421 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 22:58:04.421145 duration_in_ms=52.869
2017-12-19 22:58:04,422 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:58:04.421618
2017-12-19 22:58:04,422 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 22:58:04,422 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 22:58:04,473 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:04,474 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:58:04.473714 duration_in_ms=52.095
2017-12-19 22:58:04,475 [salt.state       ][INFO    ][28680] Running state [nova_instances] at time 22:58:04.474819
2017-12-19 22:58:04,475 [salt.state       ][INFO    ][28680] Executing state glusterfs.started for nova_instances
2017-12-19 22:58:04,476 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:04,485 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:04,535 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:04,544 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:04,601 [salt.state       ][INFO    ][28680] Volume nova_instances is already started
2017-12-19 22:58:04,601 [salt.state       ][INFO    ][28680] Completed state [nova_instances] at time 22:58:04.601021 duration_in_ms=126.202
2017-12-19 22:58:04,602 [salt.state       ][INFO    ][28680] Running state [keystone-credential-keys] at time 22:58:04.601966
2017-12-19 22:58:04,602 [salt.state       ][INFO    ][28680] Executing state glusterfs.created for keystone-credential-keys
2017-12-19 22:58:04,603 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:04,611 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:04,663 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:04,672 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:04,728 [salt.state       ][INFO    ][28680] Volume keystone-credential-keys already exists and is started.
2017-12-19 22:58:04,728 [salt.state       ][INFO    ][28680] Completed state [keystone-credential-keys] at time 22:58:04.728043 duration_in_ms=126.077
2017-12-19 22:58:04,731 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:58:04.731450
2017-12-19 22:58:04,732 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-19 22:58:04,732 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 22:58:04,788 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:04,788 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:58:04.788047 duration_in_ms=56.596
2017-12-19 22:58:04,789 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:58:04.788513
2017-12-19 22:58:04,789 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 22:58:04,789 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 22:58:04,839 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:04,839 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:58:04.838786 duration_in_ms=50.273
2017-12-19 22:58:04,839 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:58:04.839266
2017-12-19 22:58:04,840 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 22:58:04,840 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 22:58:04,894 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:04,894 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:58:04.894319 duration_in_ms=55.052
2017-12-19 22:58:04,895 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:58:04.894785
2017-12-19 22:58:04,895 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-19 22:58:04,895 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 22:58:04,947 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:04,947 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:58:04.947276 duration_in_ms=52.49
2017-12-19 22:58:04,948 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:58:04.947739
2017-12-19 22:58:04,948 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 22:58:04,948 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 22:58:05,003 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:05,004 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:58:05.003669 duration_in_ms=55.929
2017-12-19 22:58:05,004 [salt.state       ][INFO    ][28680] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:58:05.004132
2017-12-19 22:58:05,004 [salt.state       ][INFO    ][28680] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-19 22:58:05,005 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 22:58:05,056 [salt.state       ][INFO    ][28680] unless execution succeeded
2017-12-19 22:58:05,056 [salt.state       ][INFO    ][28680] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:58:05.055716 duration_in_ms=51.584
2017-12-19 22:58:05,057 [salt.state       ][INFO    ][28680] Running state [keystone-credential-keys] at time 22:58:05.056852
2017-12-19 22:58:05,057 [salt.state       ][INFO    ][28680] Executing state glusterfs.started for keystone-credential-keys
2017-12-19 22:58:05,057 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:05,065 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:05,116 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:05,125 [salt.loaded.int.module.cmdmod][INFO    ][28680] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:05,190 [salt.state       ][INFO    ][28680] Volume keystone-credential-keys is already started
2017-12-19 22:58:05,190 [salt.state       ][INFO    ][28680] Completed state [keystone-credential-keys] at time 22:58:05.189864 duration_in_ms=133.012
2017-12-19 22:58:05,192 [salt.minion      ][INFO    ][28680] Returning information for job: 20171219225800921520
2017-12-19 22:58:10,564 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command test.ping with jid 20171219225810552719
2017-12-19 22:58:10,580 [salt.minion      ][INFO    ][29191] Starting a new job with PID 29191
2017-12-19 22:58:10,606 [salt.minion      ][INFO    ][29191] Returning information for job: 20171219225810552719
2017-12-19 22:58:11,008 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command cmd.run with jid 20171219225810996116
2017-12-19 22:58:11,021 [salt.minion      ][INFO    ][29196] Starting a new job with PID 29196
2017-12-19 22:58:11,027 [salt.loaded.int.module.cmdmod][INFO    ][29196] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-19 22:58:11,161 [salt.minion      ][INFO    ][29196] Returning information for job: 20171219225810996116
2017-12-19 23:22:53,645 [salt.utils.schedule][INFO    ][21335] Running scheduled job: __mine_interval
2017-12-19 23:30:01,484 [salt.minion      ][INFO    ][21335] User sudo_ubuntu Executing command cp.push_dir with jid 20171219233001469139
2017-12-19 23:30:01,502 [salt.minion      ][INFO    ][29436] Starting a new job with PID 29436
