2017-12-19 20:36:08,658 [salt.cli.daemons ][WARNING ][2496] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-19 21:10:35,307 [salt.state       ][ERROR   ][3913] No contents found in top file
2017-12-19 21:13:57,927 [salt.utils.parsers][WARNING ][2496] Minion received a SIGTERM. Exiting.
2017-12-19 21:16:04,015 [salt.cli.daemons ][WARNING ][3220] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-19 21:19:22,302 [py.warnings      ][WARNING ][14172] /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:13,830 [salt.loaded.int.module.cmdmod][ERROR   ][14172] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-19 21:22:13,831 [salt.loaded.int.module.cmdmod][ERROR   ][14172] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-19 21:22:20,230 [salt.loaded.int.module.cmdmod][ERROR   ][14172] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-19 21:22:20,230 [salt.loaded.int.module.cmdmod][ERROR   ][14172] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-19 21:22:27,869 [salt.loaded.int.module.cmdmod][ERROR   ][14172] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-19 21:22:27,869 [salt.loaded.int.module.cmdmod][ERROR   ][14172] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-19 21:22:36,836 [salt.loaded.int.module.cmdmod][ERROR   ][14172] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-19 21:22:36,836 [salt.loaded.int.module.cmdmod][ERROR   ][14172] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-19 21:22:45,179 [salt.loaded.int.module.cmdmod][ERROR   ][14172] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-19 21:22:45,180 [salt.loaded.int.module.cmdmod][ERROR   ][14172] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-19 21:22:51,465 [salt.loaded.int.module.cmdmod][ERROR   ][14172] 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:53,738 [salt.loaded.int.module.cmdmod][INFO    ][21688] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-19 21:22:53,744 [salt.loaded.int.module.cmdmod][INFO    ][21688] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-19 21:22:53,752 [salt.loaded.int.module.cmdmod][INFO    ][21688] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-19 21:22:53,759 [salt.utils.parsers][WARNING ][3220] Minion received a SIGTERM. Exiting.
2017-12-19 21:22:54,008 [salt.cli.daemons ][INFO    ][21763] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-12-19 21:22:54,547 [salt.minion      ][INFO    ][21763] Creating minion process manager
2017-12-19 21:22:54,547 [salt.cli.daemons ][WARNING ][21763] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-19 21:22:54,547 [salt.cli.daemons ][INFO    ][21763] The Salt Minion is starting up
2017-12-19 21:22:54,547 [salt.minion      ][INFO    ][21763] Minion is starting as user 'root'
2017-12-19 21:22:54,548 [salt.utils.event ][INFO    ][21763] Starting pull socket on /var/run/salt/minion/minion_event_4fcafbd0f5_pull.ipc
2017-12-19 21:22:55,388 [salt.loaded.int.module.cmdmod][INFO    ][21763] Executing command ['date', '+%z'] in directory '/root'
2017-12-19 21:22:55,396 [salt.utils.schedule][INFO    ][21763] Updating job settings for scheduled job: __mine_interval
2017-12-19 21:22:55,398 [salt.minion      ][INFO    ][21763] Added mine.update to scheduler
2017-12-19 21:22:55,504 [salt.minion      ][INFO    ][21763] Minion is ready to receive requests!
2017-12-19 21:22:56,505 [salt.utils.schedule][INFO    ][21763] Running scheduled job: __mine_interval
2017-12-19 21:23:06,998 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171219212306976775
2017-12-19 21:23:07,014 [salt.minion      ][INFO    ][21862] Starting a new job with PID 21862
2017-12-19 21:23:08,902 [salt.state       ][INFO    ][21862] Loading fresh modules for state activity
2017-12-19 21:23:08,924 [salt.state       ][ERROR   ][21862] No contents found in top file
2017-12-19 21:23:08,926 [salt.utils.extmods][INFO    ][21862] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-19 21:23:08,928 [salt.utils.extmods][INFO    ][21862] Syncing beacons for environment 'base'
2017-12-19 21:23:08,928 [salt.utils.extmods][INFO    ][21862] Loading cache from salt://_beacons, for base)
2017-12-19 21:23:08,928 [salt.fileclient  ][INFO    ][21862] Caching directory '_beacons/' for environment 'base'
2017-12-19 21:23:08,964 [salt.utils.extmods][INFO    ][21862] Syncing modules for environment 'base'
2017-12-19 21:23:08,969 [salt.utils.extmods][INFO    ][21862] Loading cache from salt://_modules, for base)
2017-12-19 21:23:08,969 [salt.fileclient  ][INFO    ][21862] Caching directory '_modules/' for environment 'base'
2017-12-19 21:23:09,040 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-19 21:23:09,056 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-19 21:23:09,098 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-19 21:23:09,254 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-19 21:23:09,291 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-19 21:23:09,312 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-19 21:23:09,330 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/dockerng_service.py'
2017-12-19 21:23:09,338 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-19 21:23:09,367 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-19 21:23:09,415 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-19 21:23:09,425 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-19 21:23:09,434 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-19 21:23:09,464 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-19 21:23:09,535 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-19 21:23:09,590 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-19 21:23:09,601 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-19 21:23:09,669 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-19 21:23:09,700 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-19 21:23:09,770 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-19 21:23:09,890 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/modelschema.py'
2017-12-19 21:23:09,938 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-19 21:23:09,963 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-19 21:23:10,003 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-19 21:23:10,088 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-19 21:23:10,122 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-19 21:23:10,149 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-19 21:23:10,176 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-19 21:23:10,214 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-19 21:23:10,227 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-19 21:23:10,245 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-19 21:23:10,255 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-19 21:23:10,289 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-19 21:23:10,301 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-19 21:23:10,335 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-19 21:23:10,368 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-19 21:23:10,395 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-19 21:23:10,398 [salt.utils.extmods][INFO    ][21862] 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,398 [salt.utils.extmods][INFO    ][21862] 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,399 [salt.utils.extmods][INFO    ][21862] 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,399 [salt.utils.extmods][INFO    ][21862] 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,460 [salt.utils.extmods][INFO    ][21862] 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,480 [salt.utils.extmods][INFO    ][21862] 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,481 [salt.utils.extmods][INFO    ][21862] 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,481 [salt.utils.extmods][INFO    ][21862] 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,496 [salt.utils.extmods][INFO    ][21862] 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,507 [salt.utils.extmods][INFO    ][21862] 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,525 [salt.utils.extmods][INFO    ][21862] 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,535 [salt.utils.extmods][INFO    ][21862] 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,535 [salt.utils.extmods][INFO    ][21862] 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,536 [salt.utils.extmods][INFO    ][21862] 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,536 [salt.utils.extmods][INFO    ][21862] 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,537 [salt.utils.extmods][INFO    ][21862] 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,537 [salt.utils.extmods][INFO    ][21862] 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,538 [salt.utils.extmods][INFO    ][21862] 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,538 [salt.utils.extmods][INFO    ][21862] 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,539 [salt.utils.extmods][INFO    ][21862] 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,539 [salt.utils.extmods][INFO    ][21862] 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,540 [salt.utils.extmods][INFO    ][21862] 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,540 [salt.utils.extmods][INFO    ][21862] 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,547 [salt.utils.extmods][INFO    ][21862] 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,547 [salt.utils.extmods][INFO    ][21862] 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,548 [salt.utils.extmods][INFO    ][21862] 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,553 [salt.utils.extmods][INFO    ][21862] 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,554 [salt.utils.extmods][INFO    ][21862] 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,555 [salt.utils.extmods][INFO    ][21862] 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,555 [salt.utils.extmods][INFO    ][21862] 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,556 [salt.utils.extmods][INFO    ][21862] 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,556 [salt.utils.extmods][INFO    ][21862] 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,557 [salt.utils.extmods][INFO    ][21862] 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,557 [salt.utils.extmods][INFO    ][21862] 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,558 [salt.utils.extmods][INFO    ][21862] 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,558 [salt.utils.extmods][INFO    ][21862] 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,558 [salt.utils.extmods][INFO    ][21862] 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,559 [salt.utils.extmods][INFO    ][21862] 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,564 [salt.utils.extmods][INFO    ][21862] Syncing states for environment 'base'
2017-12-19 21:23:10,565 [salt.utils.extmods][INFO    ][21862] Loading cache from salt://_states, for base)
2017-12-19 21:23:10,565 [salt.fileclient  ][INFO    ][21862] Caching directory '_states/' for environment 'base'
2017-12-19 21:23:10,594 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-19 21:23:10,629 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-19 21:23:10,641 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-19 21:23:10,652 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/dockerng_service.py'
2017-12-19 21:23:10,677 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-19 21:23:10,690 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-19 21:23:10,700 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-19 21:23:10,711 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-19 21:23:10,724 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-19 21:23:10,768 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-19 21:23:10,792 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-19 21:23:10,810 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-19 21:23:10,833 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-19 21:23:10,846 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-19 21:23:10,857 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-19 21:23:10,869 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-19 21:23:10,880 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-19 21:23:10,890 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-19 21:23:10,905 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-19 21:23:10,936 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-19 21:23:10,958 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-19 21:23:10,995 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-19 21:23:11,004 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-19 21:23:11,044 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-19 21:23:11,088 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-19 21:23:11,120 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-19 21:23:11,175 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-19 21:23:11,264 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-19 21:23:11,278 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-19 21:23:11,338 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-19 21:23:11,381 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-19 21:23:11,434 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-19 21:23:11,472 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-19 21:23:11,475 [salt.utils.extmods][INFO    ][21862] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-19 21:23:11,475 [salt.utils.extmods][INFO    ][21862] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-19 21:23:11,475 [salt.utils.extmods][INFO    ][21862] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-19 21:23:11,476 [salt.utils.extmods][INFO    ][21862] 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:11,476 [salt.utils.extmods][INFO    ][21862] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-19 21:23:11,476 [salt.utils.extmods][INFO    ][21862] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-19 21:23:11,476 [salt.utils.extmods][INFO    ][21862] 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:11,477 [salt.utils.extmods][INFO    ][21862] 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:11,477 [salt.utils.extmods][INFO    ][21862] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-19 21:23:11,477 [salt.utils.extmods][INFO    ][21862] 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:11,478 [salt.utils.extmods][INFO    ][21862] 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:11,478 [salt.utils.extmods][INFO    ][21862] 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:11,478 [salt.utils.extmods][INFO    ][21862] 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:11,478 [salt.utils.extmods][INFO    ][21862] 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:11,479 [salt.utils.extmods][INFO    ][21862] 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:11,479 [salt.utils.extmods][INFO    ][21862] 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:11,479 [salt.utils.extmods][INFO    ][21862] 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:11,479 [salt.utils.extmods][INFO    ][21862] 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:11,480 [salt.utils.extmods][INFO    ][21862] 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:11,480 [salt.utils.extmods][INFO    ][21862] 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:11,480 [salt.utils.extmods][INFO    ][21862] 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:11,480 [salt.utils.extmods][INFO    ][21862] 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:11,481 [salt.utils.extmods][INFO    ][21862] 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:11,481 [salt.utils.extmods][INFO    ][21862] 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:11,481 [salt.utils.extmods][INFO    ][21862] 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:11,481 [salt.utils.extmods][INFO    ][21862] 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:11,481 [salt.utils.extmods][INFO    ][21862] 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:11,482 [salt.utils.extmods][INFO    ][21862] 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:11,482 [salt.utils.extmods][INFO    ][21862] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-19 21:23:11,482 [salt.utils.extmods][INFO    ][21862] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-19 21:23:11,483 [salt.utils.extmods][INFO    ][21862] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-19 21:23:11,483 [salt.utils.extmods][INFO    ][21862] 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:11,483 [salt.utils.extmods][INFO    ][21862] 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:11,483 [salt.utils.extmods][INFO    ][21862] 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:11,486 [salt.utils.extmods][INFO    ][21862] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-19 21:23:11,488 [salt.utils.extmods][INFO    ][21862] Syncing sdb for environment 'base'
2017-12-19 21:23:11,488 [salt.utils.extmods][INFO    ][21862] Loading cache from salt://_sdb, for base)
2017-12-19 21:23:11,488 [salt.fileclient  ][INFO    ][21862] Caching directory '_sdb/' for environment 'base'
2017-12-19 21:23:11,524 [salt.utils.extmods][INFO    ][21862] Syncing grains for environment 'base'
2017-12-19 21:23:11,524 [salt.utils.extmods][INFO    ][21862] Loading cache from salt://_grains, for base)
2017-12-19 21:23:11,524 [salt.fileclient  ][INFO    ][21862] Caching directory '_grains/' for environment 'base'
2017-12-19 21:23:11,572 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-19 21:23:11,591 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-19 21:23:11,606 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-19 21:23:11,638 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-19 21:23:11,687 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-19 21:23:11,741 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-19 21:23:11,759 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-19 21:23:11,777 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-19 21:23:11,788 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-19 21:23:11,810 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-19 21:23:11,838 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-19 21:23:11,849 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-19 21:23:11,852 [salt.utils.extmods][INFO    ][21862] 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,876 [salt.utils.extmods][INFO    ][21862] 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,877 [salt.utils.extmods][INFO    ][21862] 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,878 [salt.utils.extmods][INFO    ][21862] 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,878 [salt.utils.extmods][INFO    ][21862] 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,879 [salt.utils.extmods][INFO    ][21862] 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,879 [salt.utils.extmods][INFO    ][21862] 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,879 [salt.utils.extmods][INFO    ][21862] 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,880 [salt.utils.extmods][INFO    ][21862] 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,880 [salt.utils.extmods][INFO    ][21862] 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,881 [salt.utils.extmods][INFO    ][21862] 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,881 [salt.utils.extmods][INFO    ][21862] 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,882 [salt.utils.extmods][INFO    ][21862] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-19 21:23:11,885 [salt.utils.extmods][INFO    ][21862] Syncing renderers for environment 'base'
2017-12-19 21:23:11,894 [salt.utils.extmods][INFO    ][21862] Loading cache from salt://_renderers, for base)
2017-12-19 21:23:11,894 [salt.fileclient  ][INFO    ][21862] Caching directory '_renderers/' for environment 'base'
2017-12-19 21:23:11,937 [salt.utils.extmods][INFO    ][21862] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-19 21:23:11,939 [salt.utils.extmods][INFO    ][21862] Syncing returners for environment 'base'
2017-12-19 21:23:11,939 [salt.utils.extmods][INFO    ][21862] Loading cache from salt://_returners, for base)
2017-12-19 21:23:11,940 [salt.fileclient  ][INFO    ][21862] Caching directory '_returners/' for environment 'base'
2017-12-19 21:23:11,979 [salt.utils.extmods][INFO    ][21862] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-19 21:23:11,981 [salt.utils.extmods][INFO    ][21862] Syncing output for environment 'base'
2017-12-19 21:23:11,981 [salt.utils.extmods][INFO    ][21862] Loading cache from salt://_output, for base)
2017-12-19 21:23:11,982 [salt.fileclient  ][INFO    ][21862] Caching directory '_output/' for environment 'base'
2017-12-19 21:23:12,015 [salt.utils.extmods][INFO    ][21862] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-19 21:23:12,017 [salt.utils.extmods][INFO    ][21862] Syncing utils for environment 'base'
2017-12-19 21:23:12,017 [salt.utils.extmods][INFO    ][21862] Loading cache from salt://_utils, for base)
2017-12-19 21:23:12,017 [salt.fileclient  ][INFO    ][21862] Caching directory '_utils/' for environment 'base'
2017-12-19 21:23:12,057 [salt.utils.extmods][INFO    ][21862] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-19 21:23:12,059 [salt.utils.extmods][INFO    ][21862] Syncing log_handlers for environment 'base'
2017-12-19 21:23:12,059 [salt.utils.extmods][INFO    ][21862] Loading cache from salt://_log_handlers, for base)
2017-12-19 21:23:12,060 [salt.fileclient  ][INFO    ][21862] Caching directory '_log_handlers/' for environment 'base'
2017-12-19 21:23:12,093 [salt.utils.extmods][INFO    ][21862] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-19 21:23:12,095 [salt.utils.extmods][INFO    ][21862] Syncing proxy for environment 'base'
2017-12-19 21:23:12,096 [salt.utils.extmods][INFO    ][21862] Loading cache from salt://_proxy, for base)
2017-12-19 21:23:12,096 [salt.fileclient  ][INFO    ][21862] Caching directory '_proxy/' for environment 'base'
2017-12-19 21:23:12,120 [salt.utils.extmods][INFO    ][21862] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-19 21:23:12,122 [salt.utils.extmods][INFO    ][21862] Syncing engines for environment 'base'
2017-12-19 21:23:12,122 [salt.utils.extmods][INFO    ][21862] Loading cache from salt://_engines, for base)
2017-12-19 21:23:12,122 [salt.fileclient  ][INFO    ][21862] Caching directory '_engines/' for environment 'base'
2017-12-19 21:23:12,159 [salt.minion      ][INFO    ][21862] Returning information for job: 20171219212306976775
2017-12-19 21:23:15,944 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command state.sls with jid 20171219212315940792
2017-12-19 21:23:15,960 [salt.minion      ][INFO    ][21959] Starting a new job with PID 21959
2017-12-19 21:23:16,337 [salt.state       ][INFO    ][21959] Loading fresh modules for state activity
2017-12-19 21:23:16,361 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-19 21:23:16,377 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-19 21:23:16,455 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:16,522 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-19 21:23:16,535 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-19 21:23:16,559 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:16,613 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-19 21:23:16,629 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-19 21:23:16,671 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-19 21:23:16,691 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-19 21:23:16,703 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 21:23:16,719 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-19 21:23:16,726 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:16,735 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:16,752 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-19 21:23:16,766 [py.warnings      ][WARNING ][21959] /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,766 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:16,995 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:17,235 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-19 21:23:17,253 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-19 21:23:17,264 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-19 21:23:17,274 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-19 21:23:17,306 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-19 21:23:17,317 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-19 21:23:17,335 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-19 21:23:17,347 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-19 21:23:17,363 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-19 21:23:17,667 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-19 21:23:17,725 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-19 21:23:17,744 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:17,810 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-19 21:23:17,828 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-19 21:23:17,872 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-19 21:23:17,893 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-19 21:23:17,905 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 21:23:17,922 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-19 21:23:17,928 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:17,939 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:17,959 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-19 21:23:17,975 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:18,201 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:18,475 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-19 21:23:18,493 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-19 21:23:18,504 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-19 21:23:18,550 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-19 21:23:18,610 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-19 21:23:18,624 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-19 21:23:18,645 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-19 21:23:18,660 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-19 21:23:18,678 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-19 21:23:18,769 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-19 21:23:18,837 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-19 21:23:18,897 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:19,303 [salt.state       ][INFO    ][21959] Running state [salt-minion] at time 21:23:19.302810
2017-12-19 21:23:19,303 [salt.state       ][INFO    ][21959] Executing state pkg.installed for salt-minion
2017-12-19 21:23:19,304 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:23:19,635 [salt.state       ][INFO    ][21959] Package salt-minion is already installed
2017-12-19 21:23:19,635 [salt.state       ][INFO    ][21959] Completed state [salt-minion] at time 21:23:19.635340 duration_in_ms=332.53
2017-12-19 21:23:19,636 [salt.state       ][INFO    ][21959] Running state [salt_minion_dependency_packages] at time 21:23:19.635579
2017-12-19 21:23:19,636 [salt.state       ][INFO    ][21959] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-19 21:23:19,638 [salt.state       ][INFO    ][21959] All specified packages are already installed
2017-12-19 21:23:19,639 [salt.state       ][INFO    ][21959] Completed state [salt_minion_dependency_packages] at time 21:23:19.638553 duration_in_ms=2.974
2017-12-19 21:23:19,640 [salt.state       ][INFO    ][21959] Running state [/etc/salt/minion.d/minion.conf] at time 21:23:19.639958
2017-12-19 21:23:19,640 [salt.state       ][INFO    ][21959] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-19 21:23:19,660 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-19 21:23:19,704 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:19,761 [salt.fileclient  ][INFO    ][21959] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-19 21:23:19,795 [salt.state       ][INFO    ][21959] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-19 21:23:19,795 [salt.state       ][INFO    ][21959] Completed state [/etc/salt/minion.d/minion.conf] at time 21:23:19.795269 duration_in_ms=155.311
2017-12-19 21:23:19,796 [salt.state       ][INFO    ][21959] Running state [/etc/salt/minion.d/_virt.conf] at time 21:23:19.795597
2017-12-19 21:23:19,796 [salt.state       ][INFO    ][21959] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-19 21:23:19,956 [salt.state       ][INFO    ][21959] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-19 21:23:19,956 [salt.state       ][INFO    ][21959] Completed state [/etc/salt/minion.d/_virt.conf] at time 21:23:19.956265 duration_in_ms=160.668
2017-12-19 21:23:19,958 [salt.state       ][INFO    ][21959] Running state [salt-minion] at time 21:23:19.957899
2017-12-19 21:23:19,958 [salt.state       ][INFO    ][21959] Executing state service.running for salt-minion
2017-12-19 21:23:19,959 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-19 21:23:19,976 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-19 21:23:20,034 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-19 21:23:20,041 [salt.state       ][INFO    ][21959] The service salt-minion is already running
2017-12-19 21:23:20,042 [salt.state       ][INFO    ][21959] Completed state [salt-minion] at time 21:23:20.041576 duration_in_ms=83.677
2017-12-19 21:23:20,043 [salt.state       ][INFO    ][21959] Running state [/etc/salt/grains.d] at time 21:23:20.042844
2017-12-19 21:23:20,043 [salt.state       ][INFO    ][21959] Executing state file.directory for /etc/salt/grains.d
2017-12-19 21:23:20,044 [salt.state       ][INFO    ][21959] Directory /etc/salt/grains.d is in the correct state
2017-12-19 21:23:20,044 [salt.state       ][INFO    ][21959] Completed state [/etc/salt/grains.d] at time 21:23:20.043754 duration_in_ms=0.91
2017-12-19 21:23:20,044 [salt.state       ][INFO    ][21959] Running state [/etc/salt/grains] at time 21:23:20.044169
2017-12-19 21:23:20,044 [salt.state       ][INFO    ][21959] Executing state file.managed for /etc/salt/grains
2017-12-19 21:23:20,045 [salt.state       ][INFO    ][21959] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-19 21:23:20,045 [salt.state       ][INFO    ][21959] Completed state [/etc/salt/grains] at time 21:23:20.044806 duration_in_ms=0.636
2017-12-19 21:23:20,045 [salt.state       ][INFO    ][21959] Running state [/etc/salt/grains.d/placeholder] at time 21:23:20.045076
2017-12-19 21:23:20,045 [salt.state       ][INFO    ][21959] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-19 21:23:20,046 [salt.state       ][INFO    ][21959] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-19 21:23:20,046 [salt.state       ][INFO    ][21959] Completed state [/etc/salt/grains.d/placeholder] at time 21:23:20.045719 duration_in_ms=0.642
2017-12-19 21:23:20,046 [salt.state       ][INFO    ][21959] Running state [/etc/salt/grains.d/sphinx] at time 21:23:20.045999
2017-12-19 21:23:20,046 [salt.state       ][INFO    ][21959] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-19 21:23:20,094 [salt.state       ][INFO    ][21959] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.143
               - 127.0.0.1
               - 192.168.11.13
-              - 192.168.122.1
         system:
           name: System
           param:

2017-12-19 21:23:20,094 [salt.state       ][INFO    ][21959] Completed state [/etc/salt/grains.d/sphinx] at time 21:23:20.094451 duration_in_ms=48.452
2017-12-19 21:23:20,095 [salt.state       ][INFO    ][21959] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:23:20.095100
2017-12-19 21:23:20,095 [salt.state       ][INFO    ][21959] 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:20,096 [salt.state       ][INFO    ][21959] 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:20,096 [salt.state       ][INFO    ][21959] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:23:20.095633 duration_in_ms=0.534
2017-12-19 21:23:20,096 [salt.state       ][INFO    ][21959] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:23:20.095766
2017-12-19 21:23:20,096 [salt.state       ][INFO    ][21959] 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:20,097 [salt.loaded.int.module.cmdmod][INFO    ][21959] 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:20,217 [salt.state       ][INFO    ][21959] {'pid': 22029, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-19 21:23:20,218 [salt.state       ][INFO    ][21959] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:23:20.217727 duration_in_ms=121.96
2017-12-19 21:23:20,218 [salt.state       ][INFO    ][21959] Running state [/etc/salt/grains.d/dns_records] at time 21:23:20.218201
2017-12-19 21:23:20,218 [salt.state       ][INFO    ][21959] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-19 21:23:20,325 [salt.state       ][INFO    ][21959] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-19 21:23:20,325 [salt.state       ][INFO    ][21959] Completed state [/etc/salt/grains.d/dns_records] at time 21:23:20.325257 duration_in_ms=107.055
2017-12-19 21:23:20,326 [salt.state       ][INFO    ][21959] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:23:20.325950
2017-12-19 21:23:20,326 [salt.state       ][INFO    ][21959] 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:20,326 [salt.state       ][INFO    ][21959] 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:20,326 [salt.state       ][INFO    ][21959] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:23:20.326438 duration_in_ms=0.488
2017-12-19 21:23:20,327 [salt.state       ][INFO    ][21959] Running state [/etc/salt/grains.d/salt] at time 21:23:20.326699
2017-12-19 21:23:20,327 [salt.state       ][INFO    ][21959] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-19 21:23:20,367 [salt.state       ][INFO    ][21959] File /etc/salt/grains.d/salt is in the correct state
2017-12-19 21:23:20,367 [salt.state       ][INFO    ][21959] Completed state [/etc/salt/grains.d/salt] at time 21:23:20.367218 duration_in_ms=40.518
2017-12-19 21:23:20,368 [salt.state       ][INFO    ][21959] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:23:20.367769
2017-12-19 21:23:20,368 [salt.state       ][INFO    ][21959] 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:20,368 [salt.state       ][INFO    ][21959] 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:20,368 [salt.state       ][INFO    ][21959] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:23:20.368249 duration_in_ms=0.48
2017-12-19 21:23:20,369 [salt.state       ][INFO    ][21959] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:23:20.369385
2017-12-19 21:23:20,370 [salt.state       ][INFO    ][21959] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-19 21:23:20,370 [salt.state       ][INFO    ][21959] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-19 21:23:20,370 [salt.state       ][INFO    ][21959] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:23:20.369858 duration_in_ms=0.473
2017-12-19 21:23:20,370 [salt.state       ][INFO    ][21959] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:23:20.369978
2017-12-19 21:23:20,370 [salt.state       ][INFO    ][21959] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-19 21:23:20,371 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-12-19 21:23:20,482 [salt.state       ][INFO    ][21959] {'pid': 22031, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-19 21:23:20,482 [salt.state       ][INFO    ][21959] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:23:20.482414 duration_in_ms=112.436
2017-12-19 21:23:20,483 [salt.state       ][INFO    ][21959] Running state [mine.update] at time 21:23:20.483063
2017-12-19 21:23:20,483 [salt.state       ][INFO    ][21959] Executing state module.wait for mine.update
2017-12-19 21:23:20,484 [salt.state       ][INFO    ][21959] No changes made for mine.update
2017-12-19 21:23:20,484 [salt.state       ][INFO    ][21959] Completed state [mine.update] at time 21:23:20.483777 duration_in_ms=0.714
2017-12-19 21:23:20,484 [salt.state       ][INFO    ][21959] Running state [mine.update] at time 21:23:20.483948
2017-12-19 21:23:20,484 [salt.state       ][INFO    ][21959] Executing state module.mod_watch for mine.update
2017-12-19 21:23:21,007 [salt.state       ][INFO    ][21959] {'ret': True}
2017-12-19 21:23:21,007 [salt.state       ][INFO    ][21959] Completed state [mine.update] at time 21:23:21.006892 duration_in_ms=522.943
2017-12-19 21:23:21,007 [salt.state       ][INFO    ][21959] Running state [ca-certificates] at time 21:23:21.007239
2017-12-19 21:23:21,008 [salt.state       ][INFO    ][21959] Executing state pkg.installed for ca-certificates
2017-12-19 21:23:21,011 [salt.state       ][INFO    ][21959] Package ca-certificates is already installed
2017-12-19 21:23:21,011 [salt.state       ][INFO    ][21959] Completed state [ca-certificates] at time 21:23:21.011056 duration_in_ms=3.817
2017-12-19 21:23:21,012 [salt.state       ][INFO    ][21959] Running state [update-ca-certificates] at time 21:23:21.011757
2017-12-19 21:23:21,012 [salt.state       ][INFO    ][21959] Executing state cmd.wait for update-ca-certificates
2017-12-19 21:23:21,012 [salt.state       ][INFO    ][21959] No changes made for update-ca-certificates
2017-12-19 21:23:21,013 [salt.state       ][INFO    ][21959] Completed state [update-ca-certificates] at time 21:23:21.012589 duration_in_ms=0.832
2017-12-19 21:23:21,013 [salt.state       ][INFO    ][21959] Running state [libvirt-dev] at time 21:23:21.012864
2017-12-19 21:23:21,013 [salt.state       ][INFO    ][21959] Executing state pkg.installed for libvirt-dev
2017-12-19 21:23:21,016 [salt.state       ][INFO    ][21959] Package libvirt-dev is already installed
2017-12-19 21:23:21,016 [salt.state       ][INFO    ][21959] Completed state [libvirt-dev] at time 21:23:21.016131 duration_in_ms=3.267
2017-12-19 21:23:21,016 [salt.state       ][INFO    ][21959] Running state [pkg-config] at time 21:23:21.016400
2017-12-19 21:23:21,017 [salt.state       ][INFO    ][21959] Executing state pkg.installed for pkg-config
2017-12-19 21:23:21,019 [salt.state       ][INFO    ][21959] Package pkg-config is already installed
2017-12-19 21:23:21,020 [salt.state       ][INFO    ][21959] Completed state [pkg-config] at time 21:23:21.019664 duration_in_ms=3.263
2017-12-19 21:23:21,020 [salt.state       ][INFO    ][21959] Running state [virtng.init] at time 21:23:21.019930
2017-12-19 21:23:21,020 [salt.state       ][INFO    ][21959] Executing state module.run for virtng.init
2017-12-19 21:23:21,084 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command ['git', '--version'] in directory '/root'
2017-12-19 21:23:21,195 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:21,212 [salt.state       ][INFO    ][21959] unless execution succeeded
2017-12-19 21:23:21,212 [salt.state       ][INFO    ][21959] Completed state [virtng.init] at time 21:23:21.211820 duration_in_ms=191.889
2017-12-19 21:23:21,212 [salt.state       ][INFO    ][21959] Running state [virt.set_autostart] at time 21:23:21.212052
2017-12-19 21:23:21,212 [salt.state       ][INFO    ][21959] Executing state module.run for virt.set_autostart
2017-12-19 21:23:21,214 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:21,230 [salt.state       ][INFO    ][21959] unless execution succeeded
2017-12-19 21:23:21,230 [salt.state       ][INFO    ][21959] Completed state [virt.set_autostart] at time 21:23:21.230371 duration_in_ms=18.319
2017-12-19 21:23:21,231 [salt.state       ][INFO    ][21959] Running state [virtng.init] at time 21:23:21.230593
2017-12-19 21:23:21,231 [salt.state       ][INFO    ][21959] Executing state module.run for virtng.init
2017-12-19 21:23:21,233 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:21,246 [salt.state       ][INFO    ][21959] unless execution succeeded
2017-12-19 21:23:21,247 [salt.state       ][INFO    ][21959] Completed state [virtng.init] at time 21:23:21.246629 duration_in_ms=16.035
2017-12-19 21:23:21,247 [salt.state       ][INFO    ][21959] Running state [virt.set_autostart] at time 21:23:21.246859
2017-12-19 21:23:21,247 [salt.state       ][INFO    ][21959] Executing state module.run for virt.set_autostart
2017-12-19 21:23:21,249 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:21,263 [salt.state       ][INFO    ][21959] unless execution succeeded
2017-12-19 21:23:21,264 [salt.state       ][INFO    ][21959] Completed state [virt.set_autostart] at time 21:23:21.263540 duration_in_ms=16.68
2017-12-19 21:23:21,264 [salt.state       ][INFO    ][21959] Running state [virtng.init] at time 21:23:21.263764
2017-12-19 21:23:21,264 [salt.state       ][INFO    ][21959] Executing state module.run for virtng.init
2017-12-19 21:23:21,266 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:21,280 [salt.state       ][INFO    ][21959] unless execution succeeded
2017-12-19 21:23:21,280 [salt.state       ][INFO    ][21959] Completed state [virtng.init] at time 21:23:21.280072 duration_in_ms=16.307
2017-12-19 21:23:21,280 [salt.state       ][INFO    ][21959] Running state [virt.set_autostart] at time 21:23:21.280295
2017-12-19 21:23:21,280 [salt.state       ][INFO    ][21959] Executing state module.run for virt.set_autostart
2017-12-19 21:23:21,282 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:21,297 [salt.state       ][INFO    ][21959] unless execution succeeded
2017-12-19 21:23:21,392 [salt.state       ][INFO    ][21959] Completed state [virt.set_autostart] at time 21:23:21.391939 duration_in_ms=111.643
2017-12-19 21:23:21,392 [salt.state       ][INFO    ][21959] Running state [virtng.init] at time 21:23:21.392183
2017-12-19 21:23:21,392 [salt.state       ][INFO    ][21959] Executing state module.run for virtng.init
2017-12-19 21:23:21,394 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:21,409 [salt.state       ][INFO    ][21959] unless execution succeeded
2017-12-19 21:23:21,409 [salt.state       ][INFO    ][21959] Completed state [virtng.init] at time 21:23:21.409179 duration_in_ms=16.996
2017-12-19 21:23:21,409 [salt.state       ][INFO    ][21959] Running state [virt.set_autostart] at time 21:23:21.409409
2017-12-19 21:23:21,410 [salt.state       ][INFO    ][21959] Executing state module.run for virt.set_autostart
2017-12-19 21:23:21,412 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:21,426 [salt.state       ][INFO    ][21959] unless execution succeeded
2017-12-19 21:23:21,426 [salt.state       ][INFO    ][21959] Completed state [virt.set_autostart] at time 21:23:21.426064 duration_in_ms=16.654
2017-12-19 21:23:21,426 [salt.state       ][INFO    ][21959] Running state [virtng.init] at time 21:23:21.426286
2017-12-19 21:23:21,426 [salt.state       ][INFO    ][21959] Executing state module.run for virtng.init
2017-12-19 21:23:21,428 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:21,443 [salt.state       ][INFO    ][21959] unless execution succeeded
2017-12-19 21:23:21,443 [salt.state       ][INFO    ][21959] Completed state [virtng.init] at time 21:23:21.442760 duration_in_ms=16.473
2017-12-19 21:23:21,443 [salt.state       ][INFO    ][21959] Running state [virt.set_autostart] at time 21:23:21.442986
2017-12-19 21:23:21,443 [salt.state       ][INFO    ][21959] Executing state module.run for virt.set_autostart
2017-12-19 21:23:21,445 [salt.loaded.int.module.cmdmod][INFO    ][21959] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:21,459 [salt.state       ][INFO    ][21959] unless execution succeeded
2017-12-19 21:23:21,459 [salt.state       ][INFO    ][21959] Completed state [virt.set_autostart] at time 21:23:21.459305 duration_in_ms=16.318
2017-12-19 21:23:21,462 [salt.minion      ][INFO    ][21959] Returning information for job: 20171219212315940792
2017-12-19 21:23:47,078 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command state.sls with jid 20171219212347074020
2017-12-19 21:23:47,091 [salt.minion      ][INFO    ][22089] Starting a new job with PID 22089
2017-12-19 21:23:48,627 [salt.state       ][INFO    ][22089] Loading fresh modules for state activity
2017-12-19 21:23:48,654 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-19 21:23:48,674 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-19 21:23:48,737 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:48,805 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-19 21:23:48,820 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-19 21:23:48,845 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:48,903 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-19 21:23:48,921 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-19 21:23:48,964 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-19 21:23:49,191 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-19 21:23:49,205 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 21:23:49,222 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-19 21:23:49,233 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:49,244 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:49,266 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-19 21:23:49,280 [py.warnings      ][WARNING ][22089] /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:49,281 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:49,513 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:49,825 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-19 21:23:49,844 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-19 21:23:49,856 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-19 21:23:49,869 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-19 21:23:49,983 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-19 21:23:49,997 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-19 21:23:50,022 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-19 21:23:50,035 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-19 21:23:50,053 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-19 21:23:50,087 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-19 21:23:50,144 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-19 21:23:50,165 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:50,293 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-19 21:23:50,474 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-19 21:23:50,519 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-19 21:23:50,541 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-19 21:23:50,555 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 21:23:50,571 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-19 21:23:50,578 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:50,587 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-19 21:23:50,607 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-19 21:23:50,622 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:50,861 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'salt-minion --version' in directory '/root'
2017-12-19 21:23:51,123 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-19 21:23:51,142 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-19 21:23:51,153 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-19 21:23:51,165 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-19 21:23:51,199 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-19 21:23:51,213 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-19 21:23:51,236 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-19 21:23:51,248 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-19 21:23:51,263 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-19 21:23:51,295 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-19 21:23:51,356 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-19 21:23:51,412 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:51,744 [salt.state       ][INFO    ][22089] Running state [salt-minion] at time 21:23:51.744333
2017-12-19 21:23:51,745 [salt.state       ][INFO    ][22089] Executing state pkg.installed for salt-minion
2017-12-19 21:23:51,745 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:23:52,007 [salt.state       ][INFO    ][22089] Package salt-minion is already installed
2017-12-19 21:23:52,007 [salt.state       ][INFO    ][22089] Completed state [salt-minion] at time 21:23:52.006791 duration_in_ms=262.459
2017-12-19 21:23:52,007 [salt.state       ][INFO    ][22089] Running state [salt_minion_dependency_packages] at time 21:23:52.007032
2017-12-19 21:23:52,007 [salt.state       ][INFO    ][22089] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-19 21:23:52,010 [salt.state       ][INFO    ][22089] All specified packages are already installed
2017-12-19 21:23:52,010 [salt.state       ][INFO    ][22089] Completed state [salt_minion_dependency_packages] at time 21:23:52.009951 duration_in_ms=2.92
2017-12-19 21:23:52,012 [salt.state       ][INFO    ][22089] Running state [/etc/salt/minion.d/minion.conf] at time 21:23:52.011552
2017-12-19 21:23:52,012 [salt.state       ][INFO    ][22089] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-19 21:23:52,144 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-19 21:23:52,188 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-19 21:23:52,229 [salt.fileclient  ][INFO    ][22089] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-19 21:23:52,267 [salt.state       ][INFO    ][22089] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-19 21:23:52,268 [salt.state       ][INFO    ][22089] Completed state [/etc/salt/minion.d/minion.conf] at time 21:23:52.267528 duration_in_ms=255.976
2017-12-19 21:23:52,268 [salt.state       ][INFO    ][22089] Running state [/etc/salt/minion.d/_virt.conf] at time 21:23:52.268038
2017-12-19 21:23:52,268 [salt.state       ][INFO    ][22089] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-19 21:23:52,354 [salt.state       ][INFO    ][22089] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-19 21:23:52,354 [salt.state       ][INFO    ][22089] Completed state [/etc/salt/minion.d/_virt.conf] at time 21:23:52.354241 duration_in_ms=86.203
2017-12-19 21:23:52,356 [salt.state       ][INFO    ][22089] Running state [salt-minion] at time 21:23:52.355894
2017-12-19 21:23:52,356 [salt.state       ][INFO    ][22089] Executing state service.running for salt-minion
2017-12-19 21:23:52,357 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-19 21:23:52,373 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-19 21:23:52,380 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-19 21:23:52,389 [salt.state       ][INFO    ][22089] The service salt-minion is already running
2017-12-19 21:23:52,389 [salt.state       ][INFO    ][22089] Completed state [salt-minion] at time 21:23:52.388783 duration_in_ms=32.889
2017-12-19 21:23:52,390 [salt.state       ][INFO    ][22089] Running state [/etc/salt/grains.d] at time 21:23:52.390184
2017-12-19 21:23:52,390 [salt.state       ][INFO    ][22089] Executing state file.directory for /etc/salt/grains.d
2017-12-19 21:23:52,391 [salt.state       ][INFO    ][22089] Directory /etc/salt/grains.d is in the correct state
2017-12-19 21:23:52,391 [salt.state       ][INFO    ][22089] Completed state [/etc/salt/grains.d] at time 21:23:52.391225 duration_in_ms=1.04
2017-12-19 21:23:52,392 [salt.state       ][INFO    ][22089] Running state [/etc/salt/grains] at time 21:23:52.391701
2017-12-19 21:23:52,392 [salt.state       ][INFO    ][22089] Executing state file.managed for /etc/salt/grains
2017-12-19 21:23:52,392 [salt.state       ][INFO    ][22089] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-19 21:23:52,392 [salt.state       ][INFO    ][22089] Completed state [/etc/salt/grains] at time 21:23:52.392415 duration_in_ms=0.714
2017-12-19 21:23:52,393 [salt.state       ][INFO    ][22089] Running state [/etc/salt/grains.d/placeholder] at time 21:23:52.392706
2017-12-19 21:23:52,393 [salt.state       ][INFO    ][22089] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-19 21:23:52,393 [salt.state       ][INFO    ][22089] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-19 21:23:52,393 [salt.state       ][INFO    ][22089] Completed state [/etc/salt/grains.d/placeholder] at time 21:23:52.393374 duration_in_ms=0.669
2017-12-19 21:23:52,394 [salt.state       ][INFO    ][22089] Running state [/etc/salt/grains.d/sphinx] at time 21:23:52.393677
2017-12-19 21:23:52,394 [salt.state       ][INFO    ][22089] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-19 21:23:52,513 [salt.state       ][INFO    ][22089] File /etc/salt/grains.d/sphinx is in the correct state
2017-12-19 21:23:52,513 [salt.state       ][INFO    ][22089] Completed state [/etc/salt/grains.d/sphinx] at time 21:23:52.512954 duration_in_ms=119.277
2017-12-19 21:23:52,514 [salt.state       ][INFO    ][22089] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:23:52.513769
2017-12-19 21:23:52,514 [salt.state       ][INFO    ][22089] 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,514 [salt.state       ][INFO    ][22089] 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,514 [salt.state       ][INFO    ][22089] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:23:52.514445 duration_in_ms=0.676
2017-12-19 21:23:52,515 [salt.state       ][INFO    ][22089] Running state [/etc/salt/grains.d/dns_records] at time 21:23:52.514716
2017-12-19 21:23:52,515 [salt.state       ][INFO    ][22089] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-19 21:23:52,633 [salt.state       ][INFO    ][22089] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-19 21:23:52,633 [salt.state       ][INFO    ][22089] Completed state [/etc/salt/grains.d/dns_records] at time 21:23:52.632798 duration_in_ms=118.082
2017-12-19 21:23:52,634 [salt.state       ][INFO    ][22089] 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.633576
2017-12-19 21:23:52,634 [salt.state       ][INFO    ][22089] 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,634 [salt.state       ][INFO    ][22089] 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,634 [salt.state       ][INFO    ][22089] 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.634297 duration_in_ms=0.72
2017-12-19 21:23:52,635 [salt.state       ][INFO    ][22089] Running state [/etc/salt/grains.d/salt] at time 21:23:52.634624
2017-12-19 21:23:52,635 [salt.state       ][INFO    ][22089] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-19 21:23:52,776 [salt.state       ][INFO    ][22089] File /etc/salt/grains.d/salt is in the correct state
2017-12-19 21:23:52,776 [salt.state       ][INFO    ][22089] Completed state [/etc/salt/grains.d/salt] at time 21:23:52.776225 duration_in_ms=141.6
2017-12-19 21:23:52,777 [salt.state       ][INFO    ][22089] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:23:52.777297
2017-12-19 21:23:52,778 [salt.state       ][INFO    ][22089] 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,778 [salt.state       ][INFO    ][22089] 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,778 [salt.state       ][INFO    ][22089] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:23:52.778123 duration_in_ms=0.826
2017-12-19 21:23:52,780 [salt.state       ][INFO    ][22089] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:23:52.780288
2017-12-19 21:23:52,781 [salt.state       ][INFO    ][22089] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-19 21:23:52,781 [salt.state       ][INFO    ][22089] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-19 21:23:52,781 [salt.state       ][INFO    ][22089] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:23:52.781054 duration_in_ms=0.766
2017-12-19 21:23:52,782 [salt.state       ][INFO    ][22089] Running state [mine.update] at time 21:23:52.781736
2017-12-19 21:23:52,782 [salt.state       ][INFO    ][22089] Executing state module.wait for mine.update
2017-12-19 21:23:52,782 [salt.state       ][INFO    ][22089] No changes made for mine.update
2017-12-19 21:23:52,782 [salt.state       ][INFO    ][22089] Completed state [mine.update] at time 21:23:52.782438 duration_in_ms=0.701
2017-12-19 21:23:52,783 [salt.state       ][INFO    ][22089] Running state [ca-certificates] at time 21:23:52.782666
2017-12-19 21:23:52,783 [salt.state       ][INFO    ][22089] Executing state pkg.installed for ca-certificates
2017-12-19 21:23:52,788 [salt.state       ][INFO    ][22089] Package ca-certificates is already installed
2017-12-19 21:23:52,789 [salt.state       ][INFO    ][22089] Completed state [ca-certificates] at time 21:23:52.788645 duration_in_ms=5.979
2017-12-19 21:23:52,789 [salt.state       ][INFO    ][22089] Running state [update-ca-certificates] at time 21:23:52.789358
2017-12-19 21:23:52,790 [salt.state       ][INFO    ][22089] Executing state cmd.wait for update-ca-certificates
2017-12-19 21:23:52,790 [salt.state       ][INFO    ][22089] No changes made for update-ca-certificates
2017-12-19 21:23:52,790 [salt.state       ][INFO    ][22089] Completed state [update-ca-certificates] at time 21:23:52.790100 duration_in_ms=0.742
2017-12-19 21:23:52,790 [salt.state       ][INFO    ][22089] Running state [libvirt-dev] at time 21:23:52.790326
2017-12-19 21:23:52,791 [salt.state       ][INFO    ][22089] Executing state pkg.installed for libvirt-dev
2017-12-19 21:23:52,795 [salt.state       ][INFO    ][22089] Package libvirt-dev is already installed
2017-12-19 21:23:52,796 [salt.state       ][INFO    ][22089] Completed state [libvirt-dev] at time 21:23:52.795650 duration_in_ms=5.324
2017-12-19 21:23:52,796 [salt.state       ][INFO    ][22089] Running state [pkg-config] at time 21:23:52.795880
2017-12-19 21:23:52,796 [salt.state       ][INFO    ][22089] Executing state pkg.installed for pkg-config
2017-12-19 21:23:52,801 [salt.state       ][INFO    ][22089] Package pkg-config is already installed
2017-12-19 21:23:52,801 [salt.state       ][INFO    ][22089] Completed state [pkg-config] at time 21:23:52.801187 duration_in_ms=5.307
2017-12-19 21:23:52,801 [salt.state       ][INFO    ][22089] Running state [virtng.init] at time 21:23:52.801421
2017-12-19 21:23:52,802 [salt.state       ][INFO    ][22089] Executing state module.run for virtng.init
2017-12-19 21:23:52,848 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command ['git', '--version'] in directory '/root'
2017-12-19 21:23:53,096 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:53,114 [salt.state       ][INFO    ][22089] unless execution succeeded
2017-12-19 21:23:53,115 [salt.state       ][INFO    ][22089] Completed state [virtng.init] at time 21:23:53.114750 duration_in_ms=313.329
2017-12-19 21:23:53,115 [salt.state       ][INFO    ][22089] Running state [virt.set_autostart] at time 21:23:53.115017
2017-12-19 21:23:53,115 [salt.state       ][INFO    ][22089] Executing state module.run for virt.set_autostart
2017-12-19 21:23:53,119 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:53,139 [salt.state       ][INFO    ][22089] unless execution succeeded
2017-12-19 21:23:53,139 [salt.state       ][INFO    ][22089] Completed state [virt.set_autostart] at time 21:23:53.139211 duration_in_ms=24.194
2017-12-19 21:23:53,139 [salt.state       ][INFO    ][22089] Running state [virtng.init] at time 21:23:53.139466
2017-12-19 21:23:53,140 [salt.state       ][INFO    ][22089] Executing state module.run for virtng.init
2017-12-19 21:23:53,142 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:53,159 [salt.state       ][INFO    ][22089] unless execution succeeded
2017-12-19 21:23:53,159 [salt.state       ][INFO    ][22089] Completed state [virtng.init] at time 21:23:53.158872 duration_in_ms=19.404
2017-12-19 21:23:53,159 [salt.state       ][INFO    ][22089] Running state [virt.set_autostart] at time 21:23:53.159101
2017-12-19 21:23:53,159 [salt.state       ][INFO    ][22089] Executing state module.run for virt.set_autostart
2017-12-19 21:23:53,161 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:53,175 [salt.state       ][INFO    ][22089] unless execution succeeded
2017-12-19 21:23:53,176 [salt.state       ][INFO    ][22089] Completed state [virt.set_autostart] at time 21:23:53.175683 duration_in_ms=16.582
2017-12-19 21:23:53,176 [salt.state       ][INFO    ][22089] Running state [virtng.init] at time 21:23:53.175896
2017-12-19 21:23:53,176 [salt.state       ][INFO    ][22089] Executing state module.run for virtng.init
2017-12-19 21:23:53,178 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:53,192 [salt.state       ][INFO    ][22089] unless execution succeeded
2017-12-19 21:23:53,192 [salt.state       ][INFO    ][22089] Completed state [virtng.init] at time 21:23:53.191995 duration_in_ms=16.099
2017-12-19 21:23:53,192 [salt.state       ][INFO    ][22089] Running state [virt.set_autostart] at time 21:23:53.192214
2017-12-19 21:23:53,192 [salt.state       ][INFO    ][22089] Executing state module.run for virt.set_autostart
2017-12-19 21:23:53,194 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:53,210 [salt.state       ][INFO    ][22089] unless execution succeeded
2017-12-19 21:23:53,210 [salt.state       ][INFO    ][22089] Completed state [virt.set_autostart] at time 21:23:53.209797 duration_in_ms=17.583
2017-12-19 21:23:53,210 [salt.state       ][INFO    ][22089] Running state [virtng.init] at time 21:23:53.210008
2017-12-19 21:23:53,210 [salt.state       ][INFO    ][22089] Executing state module.run for virtng.init
2017-12-19 21:23:53,212 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:53,226 [salt.state       ][INFO    ][22089] unless execution succeeded
2017-12-19 21:23:53,227 [salt.state       ][INFO    ][22089] Completed state [virtng.init] at time 21:23:53.226554 duration_in_ms=16.545
2017-12-19 21:23:53,227 [salt.state       ][INFO    ][22089] Running state [virt.set_autostart] at time 21:23:53.226778
2017-12-19 21:23:53,227 [salt.state       ][INFO    ][22089] Executing state module.run for virt.set_autostart
2017-12-19 21:23:53,229 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:53,247 [salt.state       ][INFO    ][22089] unless execution succeeded
2017-12-19 21:23:53,247 [salt.state       ][INFO    ][22089] Completed state [virt.set_autostart] at time 21:23:53.247045 duration_in_ms=20.266
2017-12-19 21:23:53,247 [salt.state       ][INFO    ][22089] Running state [virtng.init] at time 21:23:53.247275
2017-12-19 21:23:53,248 [salt.state       ][INFO    ][22089] Executing state module.run for virtng.init
2017-12-19 21:23:53,250 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:53,266 [salt.state       ][INFO    ][22089] unless execution succeeded
2017-12-19 21:23:53,363 [salt.state       ][INFO    ][22089] Completed state [virtng.init] at time 21:23:53.362503 duration_in_ms=115.228
2017-12-19 21:23:53,363 [salt.state       ][INFO    ][22089] Running state [virt.set_autostart] at time 21:23:53.362772
2017-12-19 21:23:53,363 [salt.state       ][INFO    ][22089] Executing state module.run for virt.set_autostart
2017-12-19 21:23:53,365 [salt.loaded.int.module.cmdmod][INFO    ][22089] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-19 21:23:53,383 [salt.state       ][INFO    ][22089] unless execution succeeded
2017-12-19 21:23:53,384 [salt.state       ][INFO    ][22089] Completed state [virt.set_autostart] at time 21:23:53.383600 duration_in_ms=20.828
2017-12-19 21:23:53,386 [salt.minion      ][INFO    ][22089] Returning information for job: 20171219212347074020
2017-12-19 21:24:32,881 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171219212432873562
2017-12-19 21:24:32,900 [salt.minion      ][INFO    ][22213] Starting a new job with PID 22213
2017-12-19 21:24:36,226 [salt.state       ][INFO    ][22213] Loading fresh modules for state activity
2017-12-19 21:24:36,245 [salt.state       ][ERROR   ][22213] No contents found in top file
2017-12-19 21:24:36,246 [salt.utils.extmods][INFO    ][22213] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-19 21:24:36,250 [salt.utils.extmods][INFO    ][22213] Syncing beacons for environment 'base'
2017-12-19 21:24:36,251 [salt.utils.extmods][INFO    ][22213] Loading cache from salt://_beacons, for base)
2017-12-19 21:24:36,251 [salt.fileclient  ][INFO    ][22213] Caching directory '_beacons/' for environment 'base'
2017-12-19 21:24:36,278 [salt.utils.extmods][INFO    ][22213] Syncing modules for environment 'base'
2017-12-19 21:24:36,278 [salt.utils.extmods][INFO    ][22213] Loading cache from salt://_modules, for base)
2017-12-19 21:24:36,278 [salt.fileclient  ][INFO    ][22213] Caching directory '_modules/' for environment 'base'
2017-12-19 21:24:36,310 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-19 21:24:36,316 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-19 21:24:36,321 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-19 21:24:36,575 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-19 21:24:36,585 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-19 21:24:36,607 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-19 21:24:36,629 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/dockerng_service.py'
2017-12-19 21:24:36,637 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-19 21:24:36,647 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-19 21:24:36,664 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-19 21:24:36,691 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-19 21:24:36,726 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-19 21:24:36,734 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-19 21:24:36,793 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-19 21:24:36,808 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-19 21:24:36,820 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-19 21:24:36,853 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-19 21:24:36,894 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-19 21:24:36,910 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-19 21:24:36,919 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/modelschema.py'
2017-12-19 21:24:36,956 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-19 21:24:36,964 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-19 21:24:36,988 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-19 21:24:37,000 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-19 21:24:37,021 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-19 21:24:37,043 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-19 21:24:37,065 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-19 21:24:37,090 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-19 21:24:37,145 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-19 21:24:37,159 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-19 21:24:37,170 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-19 21:24:37,184 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-19 21:24:37,212 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-19 21:24:37,221 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-19 21:24:37,251 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-19 21:24:37,260 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-19 21:24:37,263 [salt.utils.extmods][INFO    ][22213] 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,263 [salt.utils.extmods][INFO    ][22213] 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,263 [salt.utils.extmods][INFO    ][22213] 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,263 [salt.utils.extmods][INFO    ][22213] 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,263 [salt.utils.extmods][INFO    ][22213] 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,264 [salt.utils.extmods][INFO    ][22213] 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,264 [salt.utils.extmods][INFO    ][22213] 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,264 [salt.utils.extmods][INFO    ][22213] 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,264 [salt.utils.extmods][INFO    ][22213] 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,265 [salt.utils.extmods][INFO    ][22213] 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,265 [salt.utils.extmods][INFO    ][22213] 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,265 [salt.utils.extmods][INFO    ][22213] 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,265 [salt.utils.extmods][INFO    ][22213] 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,266 [salt.utils.extmods][INFO    ][22213] 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,266 [salt.utils.extmods][INFO    ][22213] 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,266 [salt.utils.extmods][INFO    ][22213] 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,266 [salt.utils.extmods][INFO    ][22213] 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,267 [salt.utils.extmods][INFO    ][22213] 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,267 [salt.utils.extmods][INFO    ][22213] 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,267 [salt.utils.extmods][INFO    ][22213] 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,267 [salt.utils.extmods][INFO    ][22213] 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,267 [salt.utils.extmods][INFO    ][22213] 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,268 [salt.utils.extmods][INFO    ][22213] 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,268 [salt.utils.extmods][INFO    ][22213] 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,268 [salt.utils.extmods][INFO    ][22213] 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,268 [salt.utils.extmods][INFO    ][22213] 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,269 [salt.utils.extmods][INFO    ][22213] 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,269 [salt.utils.extmods][INFO    ][22213] 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,270 [salt.utils.extmods][INFO    ][22213] 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,270 [salt.utils.extmods][INFO    ][22213] 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,270 [salt.utils.extmods][INFO    ][22213] 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,270 [salt.utils.extmods][INFO    ][22213] 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,270 [salt.utils.extmods][INFO    ][22213] 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,271 [salt.utils.extmods][INFO    ][22213] 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,271 [salt.utils.extmods][INFO    ][22213] 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,271 [salt.utils.extmods][INFO    ][22213] 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,272 [salt.utils.extmods][INFO    ][22213] 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,272 [salt.utils.extmods][INFO    ][22213] 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,277 [salt.utils.extmods][INFO    ][22213] Syncing states for environment 'base'
2017-12-19 21:24:37,277 [salt.utils.extmods][INFO    ][22213] Loading cache from salt://_states, for base)
2017-12-19 21:24:37,277 [salt.fileclient  ][INFO    ][22213] Caching directory '_states/' for environment 'base'
2017-12-19 21:24:37,320 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-19 21:24:37,331 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-19 21:24:37,342 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-19 21:24:37,361 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/dockerng_service.py'
2017-12-19 21:24:37,392 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-19 21:24:37,439 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-19 21:24:37,448 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-19 21:24:37,455 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-19 21:24:37,541 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-19 21:24:37,550 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-19 21:24:37,560 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-19 21:24:37,591 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-19 21:24:37,620 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-19 21:24:37,630 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-19 21:24:37,638 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-19 21:24:37,651 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-19 21:24:37,668 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-19 21:24:37,684 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-19 21:24:37,704 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-19 21:24:37,766 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-19 21:24:37,800 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-19 21:24:37,810 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-19 21:24:37,833 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-19 21:24:37,841 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-19 21:24:37,855 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-19 21:24:37,871 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-19 21:24:37,884 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-19 21:24:37,922 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-19 21:24:37,930 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-19 21:24:37,942 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-19 21:24:38,003 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-19 21:24:38,012 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-19 21:24:38,023 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-19 21:24:38,026 [salt.utils.extmods][INFO    ][22213] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-19 21:24:38,064 [salt.utils.extmods][INFO    ][22213] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-19 21:24:38,064 [salt.utils.extmods][INFO    ][22213] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-19 21:24:38,064 [salt.utils.extmods][INFO    ][22213] 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:38,064 [salt.utils.extmods][INFO    ][22213] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-19 21:24:38,065 [salt.utils.extmods][INFO    ][22213] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-19 21:24:38,065 [salt.utils.extmods][INFO    ][22213] 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:38,065 [salt.utils.extmods][INFO    ][22213] 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:38,066 [salt.utils.extmods][INFO    ][22213] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-19 21:24:38,066 [salt.utils.extmods][INFO    ][22213] 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:38,066 [salt.utils.extmods][INFO    ][22213] 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:38,066 [salt.utils.extmods][INFO    ][22213] 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:38,067 [salt.utils.extmods][INFO    ][22213] 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:38,067 [salt.utils.extmods][INFO    ][22213] 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:38,067 [salt.utils.extmods][INFO    ][22213] 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:38,067 [salt.utils.extmods][INFO    ][22213] 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:38,068 [salt.utils.extmods][INFO    ][22213] 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:38,068 [salt.utils.extmods][INFO    ][22213] 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:38,068 [salt.utils.extmods][INFO    ][22213] 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:38,068 [salt.utils.extmods][INFO    ][22213] 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:38,069 [salt.utils.extmods][INFO    ][22213] 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:38,069 [salt.utils.extmods][INFO    ][22213] 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:38,069 [salt.utils.extmods][INFO    ][22213] 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:38,069 [salt.utils.extmods][INFO    ][22213] 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:38,070 [salt.utils.extmods][INFO    ][22213] 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:38,070 [salt.utils.extmods][INFO    ][22213] 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:38,070 [salt.utils.extmods][INFO    ][22213] 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:38,070 [salt.utils.extmods][INFO    ][22213] 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:38,071 [salt.utils.extmods][INFO    ][22213] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-19 21:24:38,071 [salt.utils.extmods][INFO    ][22213] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-19 21:24:38,071 [salt.utils.extmods][INFO    ][22213] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-19 21:24:38,071 [salt.utils.extmods][INFO    ][22213] 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:38,072 [salt.utils.extmods][INFO    ][22213] 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:38,072 [salt.utils.extmods][INFO    ][22213] 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:38,074 [salt.utils.extmods][INFO    ][22213] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-19 21:24:38,076 [salt.utils.extmods][INFO    ][22213] Syncing sdb for environment 'base'
2017-12-19 21:24:38,077 [salt.utils.extmods][INFO    ][22213] Loading cache from salt://_sdb, for base)
2017-12-19 21:24:38,077 [salt.fileclient  ][INFO    ][22213] Caching directory '_sdb/' for environment 'base'
2017-12-19 21:24:38,138 [salt.utils.extmods][INFO    ][22213] Syncing grains for environment 'base'
2017-12-19 21:24:38,138 [salt.utils.extmods][INFO    ][22213] Loading cache from salt://_grains, for base)
2017-12-19 21:24:38,138 [salt.fileclient  ][INFO    ][22213] Caching directory '_grains/' for environment 'base'
2017-12-19 21:24:38,170 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-19 21:24:38,181 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-19 21:24:38,191 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-19 21:24:38,202 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-19 21:24:38,232 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-19 21:24:38,257 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-19 21:24:38,278 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-19 21:24:38,295 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-19 21:24:38,306 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-19 21:24:38,319 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-19 21:24:38,329 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-19 21:24:38,344 [salt.fileclient  ][INFO    ][22213] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-19 21:24:38,347 [salt.utils.extmods][INFO    ][22213] 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,347 [salt.utils.extmods][INFO    ][22213] 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,348 [salt.utils.extmods][INFO    ][22213] 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,348 [salt.utils.extmods][INFO    ][22213] 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,348 [salt.utils.extmods][INFO    ][22213] 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,348 [salt.utils.extmods][INFO    ][22213] 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,349 [salt.utils.extmods][INFO    ][22213] 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,349 [salt.utils.extmods][INFO    ][22213] 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,349 [salt.utils.extmods][INFO    ][22213] 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,349 [salt.utils.extmods][INFO    ][22213] 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,350 [salt.utils.extmods][INFO    ][22213] 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,350 [salt.utils.extmods][INFO    ][22213] 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,351 [salt.utils.extmods][INFO    ][22213] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-19 21:24:38,353 [salt.utils.extmods][INFO    ][22213] Syncing renderers for environment 'base'
2017-12-19 21:24:38,353 [salt.utils.extmods][INFO    ][22213] Loading cache from salt://_renderers, for base)
2017-12-19 21:24:38,354 [salt.fileclient  ][INFO    ][22213] Caching directory '_renderers/' for environment 'base'
2017-12-19 21:24:38,400 [salt.utils.extmods][INFO    ][22213] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-19 21:24:38,402 [salt.utils.extmods][INFO    ][22213] Syncing returners for environment 'base'
2017-12-19 21:24:38,403 [salt.utils.extmods][INFO    ][22213] Loading cache from salt://_returners, for base)
2017-12-19 21:24:38,403 [salt.fileclient  ][INFO    ][22213] Caching directory '_returners/' for environment 'base'
2017-12-19 21:24:38,428 [salt.utils.extmods][INFO    ][22213] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-19 21:24:38,430 [salt.utils.extmods][INFO    ][22213] Syncing output for environment 'base'
2017-12-19 21:24:38,431 [salt.utils.extmods][INFO    ][22213] Loading cache from salt://_output, for base)
2017-12-19 21:24:38,431 [salt.fileclient  ][INFO    ][22213] Caching directory '_output/' for environment 'base'
2017-12-19 21:24:38,460 [salt.utils.extmods][INFO    ][22213] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-19 21:24:38,462 [salt.utils.extmods][INFO    ][22213] Syncing utils for environment 'base'
2017-12-19 21:24:38,462 [salt.utils.extmods][INFO    ][22213] Loading cache from salt://_utils, for base)
2017-12-19 21:24:38,462 [salt.fileclient  ][INFO    ][22213] Caching directory '_utils/' for environment 'base'
2017-12-19 21:24:38,482 [salt.utils.extmods][INFO    ][22213] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-19 21:24:38,485 [salt.utils.extmods][INFO    ][22213] Syncing log_handlers for environment 'base'
2017-12-19 21:24:38,485 [salt.utils.extmods][INFO    ][22213] Loading cache from salt://_log_handlers, for base)
2017-12-19 21:24:38,485 [salt.fileclient  ][INFO    ][22213] Caching directory '_log_handlers/' for environment 'base'
2017-12-19 21:24:38,519 [salt.utils.extmods][INFO    ][22213] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-19 21:24:38,521 [salt.utils.extmods][INFO    ][22213] Syncing proxy for environment 'base'
2017-12-19 21:24:38,522 [salt.utils.extmods][INFO    ][22213] Loading cache from salt://_proxy, for base)
2017-12-19 21:24:38,522 [salt.fileclient  ][INFO    ][22213] Caching directory '_proxy/' for environment 'base'
2017-12-19 21:24:38,549 [salt.utils.extmods][INFO    ][22213] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-19 21:24:38,551 [salt.utils.extmods][INFO    ][22213] Syncing engines for environment 'base'
2017-12-19 21:24:38,552 [salt.utils.extmods][INFO    ][22213] Loading cache from salt://_engines, for base)
2017-12-19 21:24:38,552 [salt.fileclient  ][INFO    ][22213] Caching directory '_engines/' for environment 'base'
2017-12-19 21:24:38,582 [salt.minion      ][INFO    ][22213] Returning information for job: 20171219212432873562
2017-12-19 21:39:02,082 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command test.ping with jid 20171219213902072841
2017-12-19 21:39:02,102 [salt.minion      ][INFO    ][22475] Starting a new job with PID 22475
2017-12-19 21:39:02,128 [salt.minion      ][INFO    ][22475] Returning information for job: 20171219213902072841
2017-12-19 21:42:21,291 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command state.sls with jid 20171219214221280337
2017-12-19 21:42:21,311 [salt.minion      ][INFO    ][22515] Starting a new job with PID 22515
2017-12-19 21:42:22,939 [salt.state       ][INFO    ][22515] Loading fresh modules for state activity
2017-12-19 21:42:22,963 [salt.fileclient  ][INFO    ][22515] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-19 21:42:22,979 [salt.fileclient  ][INFO    ][22515] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-19 21:42:23,003 [salt.fileclient  ][INFO    ][22515] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 21:42:23,302 [salt.state       ][INFO    ][22515] Running state [lsof] at time 21:42:23.302079
2017-12-19 21:42:23,302 [salt.state       ][INFO    ][22515] Executing state pkg.installed for lsof
2017-12-19 21:42:23,303 [salt.loaded.int.module.cmdmod][INFO    ][22515] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:42:23,557 [salt.state       ][INFO    ][22515] Package lsof is already installed
2017-12-19 21:42:23,557 [salt.state       ][INFO    ][22515] Completed state [lsof] at time 21:42:23.557380 duration_in_ms=255.302
2017-12-19 21:42:23,558 [salt.state       ][INFO    ][22515] Running state [keepalived] at time 21:42:23.557574
2017-12-19 21:42:23,558 [salt.state       ][INFO    ][22515] Executing state pkg.installed for keepalived
2017-12-19 21:42:23,573 [salt.loaded.int.module.cmdmod][INFO    ][22515] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-19 21:42:26,892 [salt.loaded.int.module.cmdmod][INFO    ][22515] 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:42:31,337 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command saltutil.find_job with jid 20171219214231323574
2017-12-19 21:42:31,353 [salt.minion      ][INFO    ][23681] Starting a new job with PID 23681
2017-12-19 21:42:31,364 [salt.minion      ][INFO    ][23681] Returning information for job: 20171219214231323574
2017-12-19 21:42:34,433 [salt.loaded.int.module.cmdmod][INFO    ][22515] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:42:34,455 [salt.state       ][INFO    ][22515] 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:42:34,463 [salt.state       ][INFO    ][22515] Loading fresh modules for state activity
2017-12-19 21:42:34,474 [salt.state       ][INFO    ][22515] Completed state [keepalived] at time 21:42:34.474255 duration_in_ms=10916.68
2017-12-19 21:42:34,477 [salt.state       ][INFO    ][22515] Running state [/etc/keepalived/keepalived.conf] at time 21:42:34.476776
2017-12-19 21:42:34,477 [salt.state       ][INFO    ][22515] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-19 21:42:34,506 [salt.fileclient  ][INFO    ][22515] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-19 21:42:34,538 [salt.fileclient  ][INFO    ][22515] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 21:42:34,544 [salt.state       ][INFO    ][22515] File changed:
New file
2017-12-19 21:42:34,544 [salt.state       ][INFO    ][22515] Completed state [/etc/keepalived/keepalived.conf] at time 21:42:34.544437 duration_in_ms=67.65
2017-12-19 21:42:34,602 [salt.state       ][INFO    ][22515] Running state [keepalived] at time 21:42:34.601548
2017-12-19 21:42:34,602 [salt.state       ][INFO    ][22515] Executing state service.running for keepalived
2017-12-19 21:42:34,603 [salt.loaded.int.module.cmdmod][INFO    ][22515] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-19 21:42:34,612 [salt.loaded.int.module.cmdmod][INFO    ][22515] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-19 21:42:34,619 [salt.loaded.int.module.cmdmod][INFO    ][22515] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-19 21:42:34,625 [salt.loaded.int.module.cmdmod][INFO    ][22515] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-19 21:42:34,633 [salt.loaded.int.module.cmdmod][INFO    ][22515] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-12-19 21:42:34,699 [salt.loaded.int.module.cmdmod][INFO    ][22515] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-19 21:42:34,707 [salt.loaded.int.module.cmdmod][INFO    ][22515] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-19 21:42:34,713 [salt.loaded.int.module.cmdmod][INFO    ][22515] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-19 21:42:34,720 [salt.state       ][INFO    ][22515] {'keepalived': True}
2017-12-19 21:42:34,721 [salt.state       ][INFO    ][22515] Completed state [keepalived] at time 21:42:34.720563 duration_in_ms=119.015
2017-12-19 21:42:34,721 [salt.minion      ][INFO    ][22515] Returning information for job: 20171219214221280337
2017-12-19 21:43:03,664 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command pillar.get with jid 20171219214303652464
2017-12-19 21:43:03,682 [salt.minion      ][INFO    ][24004] Starting a new job with PID 24004
2017-12-19 21:43:03,687 [salt.minion      ][INFO    ][24004] Returning information for job: 20171219214303652464
2017-12-19 21:48:17,077 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command state.sls with jid 20171219214817066892
2017-12-19 21:48:17,094 [salt.minion      ][INFO    ][24089] Starting a new job with PID 24089
2017-12-19 21:48:19,616 [salt.state       ][INFO    ][24089] Loading fresh modules for state activity
2017-12-19 21:48:19,641 [salt.fileclient  ][INFO    ][24089] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-19 21:48:19,663 [salt.fileclient  ][INFO    ][24089] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-19 21:48:19,934 [salt.state       ][INFO    ][24089] Running state [attr] at time 21:48:19.933934
2017-12-19 21:48:19,934 [salt.state       ][INFO    ][24089] Executing state pkg.installed for attr
2017-12-19 21:48:19,935 [salt.loaded.int.module.cmdmod][INFO    ][24089] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:48:20,241 [salt.loaded.int.module.cmdmod][INFO    ][24089] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-19 21:48:22,168 [salt.loaded.int.module.cmdmod][INFO    ][24089] 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,596 [salt.loaded.int.module.cmdmod][INFO    ][24089] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:48:24,622 [salt.state       ][INFO    ][24089] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-12-19 21:48:24,630 [salt.state       ][INFO    ][24089] Loading fresh modules for state activity
2017-12-19 21:48:24,642 [salt.state       ][INFO    ][24089] Completed state [attr] at time 21:48:24.642430 duration_in_ms=4708.496
2017-12-19 21:48:24,648 [salt.state       ][INFO    ][24089] Running state [glusterfs-server] at time 21:48:24.647695
2017-12-19 21:48:24,648 [salt.state       ][INFO    ][24089] Executing state pkg.installed for glusterfs-server
2017-12-19 21:48:24,836 [salt.loaded.int.module.cmdmod][INFO    ][24089] 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,216 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command saltutil.find_job with jid 20171219214827157960
2017-12-19 21:48:27,231 [salt.minion      ][INFO    ][24960] Starting a new job with PID 24960
2017-12-19 21:48:27,243 [salt.minion      ][INFO    ][24960] Returning information for job: 20171219214827157960
2017-12-19 21:48:37,416 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command saltutil.find_job with jid 20171219214837404456
2017-12-19 21:48:37,433 [salt.minion      ][INFO    ][24966] Starting a new job with PID 24966
2017-12-19 21:48:37,445 [salt.minion      ][INFO    ][24966] Returning information for job: 20171219214837404456
2017-12-19 21:48:47,614 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command saltutil.find_job with jid 20171219214847603849
2017-12-19 21:48:47,629 [salt.minion      ][INFO    ][25027] Starting a new job with PID 25027
2017-12-19 21:48:47,640 [salt.minion      ][INFO    ][25027] Returning information for job: 20171219214847603849
2017-12-19 21:48:57,823 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command saltutil.find_job with jid 20171219214857811506
2017-12-19 21:48:57,838 [salt.minion      ][INFO    ][26460] Starting a new job with PID 26460
2017-12-19 21:48:57,854 [salt.minion      ][INFO    ][26460] Returning information for job: 20171219214857811506
2017-12-19 21:48:58,604 [salt.loaded.int.module.cmdmod][INFO    ][24089] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:48:58,628 [salt.state       ][INFO    ][24089] 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:58,635 [salt.state       ][INFO    ][24089] Loading fresh modules for state activity
2017-12-19 21:48:58,647 [salt.state       ][INFO    ][24089] Completed state [glusterfs-server] at time 21:48:58.647083 duration_in_ms=33999.387
2017-12-19 21:48:58,652 [salt.state       ][INFO    ][24089] Running state [bc] at time 21:48:58.651736
2017-12-19 21:48:58,652 [salt.state       ][INFO    ][24089] Executing state pkg.installed for bc
2017-12-19 21:48:58,890 [salt.loaded.int.module.cmdmod][INFO    ][24089] 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:01,791 [salt.loaded.int.module.cmdmod][INFO    ][24089] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:49:01,817 [salt.state       ][INFO    ][24089] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-12-19 21:49:01,826 [salt.state       ][INFO    ][24089] Loading fresh modules for state activity
2017-12-19 21:49:01,839 [salt.state       ][INFO    ][24089] Completed state [bc] at time 21:49:01.839400 duration_in_ms=3187.662
2017-12-19 21:49:01,903 [salt.state       ][INFO    ][24089] Running state [glusterfs-server] at time 21:49:01.903151
2017-12-19 21:49:01,903 [salt.state       ][INFO    ][24089] Executing state service.running for glusterfs-server
2017-12-19 21:49:01,905 [salt.loaded.int.module.cmdmod][INFO    ][24089] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-19 21:49:01,915 [salt.loaded.int.module.cmdmod][INFO    ][24089] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-19 21:49:01,923 [salt.loaded.int.module.cmdmod][INFO    ][24089] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-19 21:49:01,931 [salt.state       ][INFO    ][24089] The service glusterfs-server is already running
2017-12-19 21:49:01,931 [salt.state       ][INFO    ][24089] Completed state [glusterfs-server] at time 21:49:01.931048 duration_in_ms=27.898
2017-12-19 21:49:01,933 [salt.state       ][INFO    ][24089] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:49:01.932810
2017-12-19 21:49:01,933 [salt.state       ][INFO    ][24089] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-19 21:49:01,939 [salt.state       ][INFO    ][24089] File changed:
New file
2017-12-19 21:49:01,939 [salt.state       ][INFO    ][24089] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:49:01.938787 duration_in_ms=5.977
2017-12-19 21:49:01,939 [salt.state       ][INFO    ][24089] Running state [/srv/glusterfs/glance] at time 21:49:01.938941
2017-12-19 21:49:01,939 [salt.state       ][INFO    ][24089] Executing state file.directory for /srv/glusterfs/glance
2017-12-19 21:49:01,940 [salt.state       ][INFO    ][24089] {'/srv/glusterfs/glance': 'New Dir'}
2017-12-19 21:49:01,940 [salt.state       ][INFO    ][24089] Completed state [/srv/glusterfs/glance] at time 21:49:01.939760 duration_in_ms=0.818
2017-12-19 21:49:01,940 [salt.state       ][INFO    ][24089] Running state [/srv/glusterfs/keystone-keys] at time 21:49:01.939899
2017-12-19 21:49:01,940 [salt.state       ][INFO    ][24089] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-19 21:49:01,940 [salt.state       ][INFO    ][24089] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-12-19 21:49:01,941 [salt.state       ][INFO    ][24089] Completed state [/srv/glusterfs/keystone-keys] at time 21:49:01.940527 duration_in_ms=0.628
2017-12-19 21:49:01,941 [salt.state       ][INFO    ][24089] Running state [/srv/glusterfs/nova_instances] at time 21:49:01.940664
2017-12-19 21:49:01,941 [salt.state       ][INFO    ][24089] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-19 21:49:01,941 [salt.state       ][INFO    ][24089] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-12-19 21:49:01,941 [salt.state       ][INFO    ][24089] Completed state [/srv/glusterfs/nova_instances] at time 21:49:01.941248 duration_in_ms=0.583
2017-12-19 21:49:01,941 [salt.state       ][INFO    ][24089] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:49:01.941383
2017-12-19 21:49:01,942 [salt.state       ][INFO    ][24089] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-19 21:49:01,942 [salt.state       ][INFO    ][24089] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-12-19 21:49:01,942 [salt.state       ][INFO    ][24089] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:49:01.941969 duration_in_ms=0.586
2017-12-19 21:49:01,943 [salt.minion      ][INFO    ][24089] Returning information for job: 20171219214817066892
2017-12-19 21:49:04,192 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command test.ping with jid 20171219214904181462
2017-12-19 21:49:04,208 [salt.minion      ][INFO    ][26932] Starting a new job with PID 26932
2017-12-19 21:49:04,232 [salt.minion      ][INFO    ][26932] Returning information for job: 20171219214904181462
2017-12-19 21:49:04,367 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command state.sls with jid 20171219214904356127
2017-12-19 21:49:04,383 [salt.minion      ][INFO    ][26937] Starting a new job with PID 26937
2017-12-19 21:49:06,067 [salt.state       ][INFO    ][26937] Loading fresh modules for state activity
2017-12-19 21:49:06,088 [salt.fileclient  ][INFO    ][26937] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-19 21:49:06,122 [salt.fileclient  ][INFO    ][26937] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-19 21:49:06,193 [salt.fileclient  ][INFO    ][26937] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-19 21:49:06,212 [salt.fileclient  ][INFO    ][26937] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-19 21:49:06,467 [salt.state       ][INFO    ][26937] Running state [attr] at time 21:49:06.467223
2017-12-19 21:49:06,468 [salt.state       ][INFO    ][26937] Executing state pkg.installed for attr
2017-12-19 21:49:06,468 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 21:49:06,745 [salt.state       ][INFO    ][26937] Package attr is already installed
2017-12-19 21:49:06,745 [salt.state       ][INFO    ][26937] Completed state [attr] at time 21:49:06.745351 duration_in_ms=278.128
2017-12-19 21:49:06,746 [salt.state       ][INFO    ][26937] Running state [glusterfs-server] at time 21:49:06.745562
2017-12-19 21:49:06,746 [salt.state       ][INFO    ][26937] Executing state pkg.installed for glusterfs-server
2017-12-19 21:49:06,748 [salt.state       ][INFO    ][26937] Package glusterfs-server is already installed
2017-12-19 21:49:06,749 [salt.state       ][INFO    ][26937] Completed state [glusterfs-server] at time 21:49:06.748476 duration_in_ms=2.914
2017-12-19 21:49:06,749 [salt.state       ][INFO    ][26937] Running state [bc] at time 21:49:06.748621
2017-12-19 21:49:06,749 [salt.state       ][INFO    ][26937] Executing state pkg.installed for bc
2017-12-19 21:49:06,751 [salt.state       ][INFO    ][26937] Package bc is already installed
2017-12-19 21:49:06,751 [salt.state       ][INFO    ][26937] Completed state [bc] at time 21:49:06.751411 duration_in_ms=2.789
2017-12-19 21:49:06,752 [salt.state       ][INFO    ][26937] Running state [glusterfs-server] at time 21:49:06.752235
2017-12-19 21:49:06,752 [salt.state       ][INFO    ][26937] Executing state service.running for glusterfs-server
2017-12-19 21:49:06,753 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-19 21:49:06,763 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-19 21:49:06,806 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-19 21:49:06,822 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-19 21:49:06,829 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-19 21:49:06,837 [salt.state       ][INFO    ][26937] The service glusterfs-server is already running
2017-12-19 21:49:06,838 [salt.state       ][INFO    ][26937] Completed state [glusterfs-server] at time 21:49:06.837542 duration_in_ms=85.306
2017-12-19 21:49:06,839 [salt.state       ][INFO    ][26937] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:49:06.838953
2017-12-19 21:49:06,839 [salt.state       ][INFO    ][26937] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-19 21:49:06,852 [salt.state       ][INFO    ][26937] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-19 21:49:06,852 [salt.state       ][INFO    ][26937] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:49:06.851864 duration_in_ms=12.91
2017-12-19 21:49:06,852 [salt.state       ][INFO    ][26937] Running state [/srv/glusterfs/glance] at time 21:49:06.852021
2017-12-19 21:49:06,852 [salt.state       ][INFO    ][26937] Executing state file.directory for /srv/glusterfs/glance
2017-12-19 21:49:06,852 [salt.state       ][INFO    ][26937] Directory /srv/glusterfs/glance is in the correct state
2017-12-19 21:49:06,853 [salt.state       ][INFO    ][26937] Completed state [/srv/glusterfs/glance] at time 21:49:06.852631 duration_in_ms=0.609
2017-12-19 21:49:06,853 [salt.state       ][INFO    ][26937] Running state [/srv/glusterfs/keystone-keys] at time 21:49:06.852779
2017-12-19 21:49:06,853 [salt.state       ][INFO    ][26937] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-19 21:49:06,853 [salt.state       ][INFO    ][26937] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-19 21:49:06,853 [salt.state       ][INFO    ][26937] Completed state [/srv/glusterfs/keystone-keys] at time 21:49:06.853357 duration_in_ms=0.577
2017-12-19 21:49:06,854 [salt.state       ][INFO    ][26937] Running state [/srv/glusterfs/nova_instances] at time 21:49:06.853505
2017-12-19 21:49:06,854 [salt.state       ][INFO    ][26937] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-19 21:49:06,854 [salt.state       ][INFO    ][26937] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-19 21:49:06,854 [salt.state       ][INFO    ][26937] Completed state [/srv/glusterfs/nova_instances] at time 21:49:06.854094 duration_in_ms=0.589
2017-12-19 21:49:06,854 [salt.state       ][INFO    ][26937] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:49:06.854241
2017-12-19 21:49:06,854 [salt.state       ][INFO    ][26937] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-19 21:49:06,855 [salt.state       ][INFO    ][26937] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-19 21:49:06,855 [salt.state       ][INFO    ][26937] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:49:06.854838 duration_in_ms=0.596
2017-12-19 21:49:06,911 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command ['git', '--version'] in directory '/root'
2017-12-19 21:49:06,996 [salt.state       ][INFO    ][26937] Running state [sleep 5] at time 21:49:06.995730
2017-12-19 21:49:06,996 [salt.state       ][INFO    ][26937] Executing state cmd.wait for sleep 5
2017-12-19 21:49:06,996 [salt.state       ][INFO    ][26937] No changes made for sleep 5
2017-12-19 21:49:06,996 [salt.state       ][INFO    ][26937] Completed state [sleep 5] at time 21:49:06.996301 duration_in_ms=0.573
2017-12-19 21:49:06,997 [salt.state       ][INFO    ][26937] Running state [10.167.4.141] at time 21:49:06.996713
2017-12-19 21:49:06,997 [salt.state       ][INFO    ][26937] Executing state glusterfs.peered for 10.167.4.141
2017-12-19 21:49:06,997 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:07,008 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:07,069 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:07,078 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:07,439 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:07,451 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:07,540 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:07,551 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:07,609 [salt.state       ][INFO    ][26937] {'new': {'10.167.4.141': []}, 'old': None}
2017-12-19 21:49:07,609 [salt.state       ][INFO    ][26937] Completed state [10.167.4.141] at time 21:49:07.609436 duration_in_ms=612.723
2017-12-19 21:49:07,612 [salt.state       ][INFO    ][26937] Running state [10.167.4.142] at time 21:49:07.611864
2017-12-19 21:49:07,616 [salt.state       ][INFO    ][26937] Executing state glusterfs.peered for 10.167.4.142
2017-12-19 21:49:07,617 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:07,628 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:07,721 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:07,732 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:08,052 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:08,064 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:08,138 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:08,148 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:08,204 [salt.state       ][INFO    ][26937] {'new': {'10.167.4.141': [], '10.167.4.142': []}, 'old': {'10.167.4.141': []}}
2017-12-19 21:49:08,204 [salt.state       ][INFO    ][26937] Completed state [10.167.4.142] at time 21:49:08.203921 duration_in_ms=592.056
2017-12-19 21:49:08,206 [salt.state       ][INFO    ][26937] Running state [10.167.4.143] at time 21:49:08.206092
2017-12-19 21:49:08,206 [salt.state       ][INFO    ][26937] Executing state glusterfs.peered for 10.167.4.143
2017-12-19 21:49:08,207 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:08,217 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:08,329 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:08,341 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:08,394 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:08,404 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:08,456 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:08,465 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:08,516 [salt.state       ][INFO    ][26937] Peering with localhost is not needed
2017-12-19 21:49:08,516 [salt.state       ][INFO    ][26937] Completed state [10.167.4.143] at time 21:49:08.515925 duration_in_ms=309.833
2017-12-19 21:49:08,517 [salt.state       ][INFO    ][26937] Running state [glance] at time 21:49:08.516757
2017-12-19 21:49:08,517 [salt.state       ][INFO    ][26937] Executing state glusterfs.created for glance
2017-12-19 21:49:08,517 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:08,527 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:08,579 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:08,588 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:09,330 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:09,343 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:12,055 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:12,068 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:12,125 [salt.state       ][INFO    ][26937] {'new': ['glance'], 'old': []}
2017-12-19 21:49:12,125 [salt.state       ][INFO    ][26937] Completed state [glance] at time 21:49:12.125379 duration_in_ms=3608.622
2017-12-19 21:49:12,129 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:12.128632
2017-12-19 21:49:12,129 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 21:49:12,129 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:12,185 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-12-19 21:49:12,840 [salt.state       ][INFO    ][26937] {'pid': 27200, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:12,840 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:12.840076 duration_in_ms=711.444
2017-12-19 21:49:12,841 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:49:12.840659
2017-12-19 21:49:12,841 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-19 21:49:12,842 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 21:49:12,902 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-12-19 21:49:13,487 [salt.state       ][INFO    ][26937] {'pid': 27240, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:13,487 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:49:13.487423 duration_in_ms=646.763
2017-12-19 21:49:13,488 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:49:13.487980
2017-12-19 21:49:13,488 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-19 21:49:13,489 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 21:49:13,551 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-12-19 21:49:14,172 [salt.state       ][INFO    ][26937] {'pid': 27277, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:14,173 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:49:14.172769 duration_in_ms=684.788
2017-12-19 21:49:14,173 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:14.173417
2017-12-19 21:49:14,174 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 21:49:14,174 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 21:49:14,236 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-12-19 21:49:14,407 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command saltutil.find_job with jid 20171219214914396220
2017-12-19 21:49:14,424 [salt.minion      ][INFO    ][27326] Starting a new job with PID 27326
2017-12-19 21:49:14,438 [salt.minion      ][INFO    ][27326] Returning information for job: 20171219214914396220
2017-12-19 21:49:14,821 [salt.state       ][INFO    ][26937] {'pid': 27314, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:14,822 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:14.821437 duration_in_ms=648.019
2017-12-19 21:49:14,822 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:14.822077
2017-12-19 21:49:14,822 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 21:49:14,823 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:14,879 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-12-19 21:49:15,516 [salt.state       ][INFO    ][26937] {'pid': 27359, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:15,516 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:15.516140 duration_in_ms=694.062
2017-12-19 21:49:15,517 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:49:15.517349
2017-12-19 21:49:15,518 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-19 21:49:15,519 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 21:49:15,581 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-12-19 21:49:16,228 [salt.state       ][INFO    ][26937] {'pid': 27397, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:16,229 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:49:16.228778 duration_in_ms=711.429
2017-12-19 21:49:16,230 [salt.state       ][INFO    ][26937] Running state [glance] at time 21:49:16.230051
2017-12-19 21:49:16,230 [salt.state       ][INFO    ][26937] Executing state glusterfs.started for glance
2017-12-19 21:49:16,231 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:16,244 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:16,303 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:16,313 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:16,374 [salt.state       ][INFO    ][26937] Volume glance is already started
2017-12-19 21:49:16,374 [salt.state       ][INFO    ][26937] Completed state [glance] at time 21:49:16.373993 duration_in_ms=143.942
2017-12-19 21:49:16,375 [salt.state       ][INFO    ][26937] Running state [keystone-keys] at time 21:49:16.374991
2017-12-19 21:49:16,375 [salt.state       ][INFO    ][26937] Executing state glusterfs.created for keystone-keys
2017-12-19 21:49:16,376 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:16,386 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:16,440 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:16,449 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:17,263 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:17,274 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:19,990 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:20,002 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:20,058 [salt.state       ][INFO    ][26937] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-12-19 21:49:20,058 [salt.state       ][INFO    ][26937] Completed state [keystone-keys] at time 21:49:20.057981 duration_in_ms=3682.99
2017-12-19 21:49:20,062 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:49:20.062107
2017-12-19 21:49:20,062 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-19 21:49:20,063 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 21:49:20,117 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-12-19 21:49:20,745 [salt.state       ][INFO    ][26937] {'pid': 27549, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:20,745 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:49:20.745391 duration_in_ms=683.283
2017-12-19 21:49:20,746 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:20.745996
2017-12-19 21:49:20,746 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 21:49:20,747 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:20,806 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-12-19 21:49:21,425 [salt.state       ][INFO    ][26937] {'pid': 27586, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:21,425 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:21.425217 duration_in_ms=679.22
2017-12-19 21:49:21,426 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:21.425819
2017-12-19 21:49:21,426 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 21:49:21,427 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 21:49:21,486 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-12-19 21:49:22,102 [salt.state       ][INFO    ][26937] {'pid': 27625, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:22,102 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:22.102000 duration_in_ms=676.18
2017-12-19 21:49:22,103 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:22.102761
2017-12-19 21:49:22,103 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 21:49:22,104 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:22,165 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-12-19 21:49:22,786 [salt.state       ][INFO    ][26937] {'pid': 27662, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:22,786 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:22.785851 duration_in_ms=683.09
2017-12-19 21:49:22,787 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:49:22.786385
2017-12-19 21:49:22,787 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-19 21:49:22,788 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 21:49:22,846 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-12-19 21:49:23,596 [salt.state       ][INFO    ][26937] {'pid': 27702, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:23,596 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:49:23.596289 duration_in_ms=809.904
2017-12-19 21:49:23,597 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:49:23.596869
2017-12-19 21:49:23,597 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-19 21:49:23,598 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 21:49:23,657 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-12-19 21:49:24,270 [salt.state       ][INFO    ][26937] {'pid': 27740, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:24,270 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:49:24.270307 duration_in_ms=673.437
2017-12-19 21:49:24,272 [salt.state       ][INFO    ][26937] Running state [keystone-keys] at time 21:49:24.271598
2017-12-19 21:49:24,272 [salt.state       ][INFO    ][26937] Executing state glusterfs.started for keystone-keys
2017-12-19 21:49:24,272 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:24,285 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:24,341 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:24,351 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:24,411 [salt.state       ][INFO    ][26937] Volume keystone-keys is already started
2017-12-19 21:49:24,411 [salt.state       ][INFO    ][26937] Completed state [keystone-keys] at time 21:49:24.411335 duration_in_ms=139.736
2017-12-19 21:49:24,412 [salt.state       ][INFO    ][26937] Running state [nova_instances] at time 21:49:24.412284
2017-12-19 21:49:24,413 [salt.state       ][INFO    ][26937] Executing state glusterfs.created for nova_instances
2017-12-19 21:49:24,413 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:24,423 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:24,479 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:24,489 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:24,551 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command saltutil.find_job with jid 20171219214924539853
2017-12-19 21:49:24,564 [salt.minion      ][INFO    ][27808] Starting a new job with PID 27808
2017-12-19 21:49:24,575 [salt.minion      ][INFO    ][27808] Returning information for job: 20171219214924539853
2017-12-19 21:49:25,189 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:25,201 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:27,913 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:27,926 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:27,984 [salt.state       ][INFO    ][26937] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-12-19 21:49:27,985 [salt.state       ][INFO    ][26937] Completed state [nova_instances] at time 21:49:27.984492 duration_in_ms=3572.207
2017-12-19 21:49:27,988 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:27.988085
2017-12-19 21:49:27,988 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 21:49:27,989 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:28,045 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-12-19 21:49:28,764 [salt.state       ][INFO    ][26937] {'pid': 27899, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:28,764 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:28.764236 duration_in_ms=776.15
2017-12-19 21:49:28,765 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 21:49:28.764849
2017-12-19 21:49:28,765 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-19 21:49:28,766 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 21:49:28,825 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-12-19 21:49:29,454 [salt.state       ][INFO    ][26937] {'pid': 27938, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:29,455 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 21:49:29.454677 duration_in_ms=689.826
2017-12-19 21:49:29,455 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 21:49:29.455402
2017-12-19 21:49:29,456 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-19 21:49:29,456 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 21:49:29,518 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'True'' in directory '/root'
2017-12-19 21:49:30,137 [salt.state       ][INFO    ][26937] {'pid': 27975, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:30,137 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 21:49:30.136845 duration_in_ms=681.442
2017-12-19 21:49:30,137 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:30.137441
2017-12-19 21:49:30,138 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 21:49:30,138 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 21:49:30,201 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-12-19 21:49:30,833 [salt.state       ][INFO    ][26937] {'pid': 28012, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:30,834 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:30.833731 duration_in_ms=696.288
2017-12-19 21:49:30,834 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 21:49:30.834336
2017-12-19 21:49:30,835 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-19 21:49:30,835 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 21:49:30,896 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'True'' in directory '/root'
2017-12-19 21:49:31,554 [salt.state       ][INFO    ][26937] {'pid': 28051, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:31,555 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 21:49:31.554533 duration_in_ms=720.196
2017-12-19 21:49:31,555 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:31.555126
2017-12-19 21:49:31,555 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 21:49:31,556 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:31,615 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-12-19 21:49:32,288 [salt.state       ][INFO    ][26937] {'pid': 28088, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:32,288 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:32.288297 duration_in_ms=733.171
2017-12-19 21:49:32,290 [salt.state       ][INFO    ][26937] Running state [nova_instances] at time 21:49:32.289502
2017-12-19 21:49:32,290 [salt.state       ][INFO    ][26937] Executing state glusterfs.started for nova_instances
2017-12-19 21:49:32,290 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:32,304 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:32,365 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:32,377 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:32,438 [salt.state       ][INFO    ][26937] Volume nova_instances is already started
2017-12-19 21:49:32,438 [salt.state       ][INFO    ][26937] Completed state [nova_instances] at time 21:49:32.437844 duration_in_ms=148.341
2017-12-19 21:49:32,439 [salt.state       ][INFO    ][26937] Running state [keystone-credential-keys] at time 21:49:32.438814
2017-12-19 21:49:32,439 [salt.state       ][INFO    ][26937] Executing state glusterfs.created for keystone-credential-keys
2017-12-19 21:49:32,440 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:32,449 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:32,505 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:32,516 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:33,245 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:33,257 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:34,692 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command saltutil.find_job with jid 20171219214934681322
2017-12-19 21:49:34,706 [salt.minion      ][INFO    ][28207] Starting a new job with PID 28207
2017-12-19 21:49:34,716 [salt.minion      ][INFO    ][28207] Returning information for job: 20171219214934681322
2017-12-19 21:49:35,970 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:35,983 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:36,039 [salt.state       ][INFO    ][26937] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-12-19 21:49:36,040 [salt.state       ][INFO    ][26937] Completed state [keystone-credential-keys] at time 21:49:36.039765 duration_in_ms=3600.949
2017-12-19 21:49:36,043 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:49:36.043463
2017-12-19 21:49:36,044 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-19 21:49:36,044 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 21:49:36,100 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-12-19 21:49:36,741 [salt.state       ][INFO    ][26937] {'pid': 28251, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:36,741 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:49:36.741026 duration_in_ms=697.563
2017-12-19 21:49:36,742 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:36.741604
2017-12-19 21:49:36,742 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 21:49:36,742 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 21:49:36,805 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-12-19 21:49:37,530 [salt.state       ][INFO    ][26937] {'pid': 28288, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:37,531 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 21:49:37.530745 duration_in_ms=789.139
2017-12-19 21:49:37,532 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:37.531734
2017-12-19 21:49:37,532 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 21:49:37,533 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:37,595 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-12-19 21:49:38,314 [salt.state       ][INFO    ][26937] {'pid': 28325, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:38,315 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:49:38.314720 duration_in_ms=782.986
2017-12-19 21:49:38,315 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:49:38.315314
2017-12-19 21:49:38,316 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-19 21:49:38,317 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 21:49:38,381 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-12-19 21:49:39,063 [salt.state       ][INFO    ][26937] {'pid': 28364, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:39,063 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:49:39.062977 duration_in_ms=747.661
2017-12-19 21:49:39,064 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:39.063586
2017-12-19 21:49:39,064 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 21:49:39,065 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 21:49:39,128 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-12-19 21:49:39,708 [salt.state       ][INFO    ][26937] {'pid': 28403, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:39,708 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:49:39.707781 duration_in_ms=644.194
2017-12-19 21:49:39,709 [salt.state       ][INFO    ][26937] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:49:39.708578
2017-12-19 21:49:39,709 [salt.state       ][INFO    ][26937] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-19 21:49:39,710 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 21:49:39,770 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-12-19 21:49:40,428 [salt.state       ][INFO    ][26937] {'pid': 28440, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-12-19 21:49:40,429 [salt.state       ][INFO    ][26937] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:49:40.428751 duration_in_ms=720.173
2017-12-19 21:49:40,430 [salt.state       ][INFO    ][26937] Running state [keystone-credential-keys] at time 21:49:40.429963
2017-12-19 21:49:40,430 [salt.state       ][INFO    ][26937] Executing state glusterfs.started for keystone-credential-keys
2017-12-19 21:49:40,431 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:40,444 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:40,502 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --version' in directory '/root'
2017-12-19 21:49:40,513 [salt.loaded.int.module.cmdmod][INFO    ][26937] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 21:49:40,571 [salt.state       ][INFO    ][26937] Volume keystone-credential-keys is already started
2017-12-19 21:49:40,572 [salt.state       ][INFO    ][26937] Completed state [keystone-credential-keys] at time 21:49:40.571556 duration_in_ms=141.591
2017-12-19 21:49:40,574 [salt.minion      ][INFO    ][26937] Returning information for job: 20171219214904356127
2017-12-19 21:49:51,441 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command test.ping with jid 20171219214951430253
2017-12-19 21:49:51,456 [salt.minion      ][INFO    ][28494] Starting a new job with PID 28494
2017-12-19 21:49:51,482 [salt.minion      ][INFO    ][28494] Returning information for job: 20171219214951430253
2017-12-19 21:49:51,614 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command cmd.run with jid 20171219214951603272
2017-12-19 21:49:51,629 [salt.minion      ][INFO    ][28500] Starting a new job with PID 28500
2017-12-19 21:49:51,634 [salt.loaded.int.module.cmdmod][INFO    ][28500] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-19 21:49:51,750 [salt.minion      ][INFO    ][28500] Returning information for job: 20171219214951603272
2017-12-19 22:22:56,505 [salt.utils.schedule][INFO    ][21763] Running scheduled job: __mine_interval
2017-12-19 22:56:39,113 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command test.ping with jid 20171219225639106542
2017-12-19 22:56:39,138 [salt.minion      ][INFO    ][29472] Starting a new job with PID 29472
2017-12-19 22:56:39,206 [salt.minion      ][INFO    ][29472] Returning information for job: 20171219225639106542
2017-12-19 22:57:06,521 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command state.sls with jid 20171219225706509628
2017-12-19 22:57:06,535 [salt.minion      ][INFO    ][29479] Starting a new job with PID 29479
2017-12-19 22:57:07,048 [salt.state       ][INFO    ][29479] Loading fresh modules for state activity
2017-12-19 22:57:07,075 [salt.fileclient  ][INFO    ][29479] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-19 22:57:07,093 [salt.fileclient  ][INFO    ][29479] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-19 22:57:07,127 [salt.fileclient  ][INFO    ][29479] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 22:57:07,762 [salt.state       ][INFO    ][29479] Running state [lsof] at time 22:57:07.762361
2017-12-19 22:57:07,763 [salt.state       ][INFO    ][29479] Executing state pkg.installed for lsof
2017-12-19 22:57:07,763 [salt.loaded.int.module.cmdmod][INFO    ][29479] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 22:57:08,281 [salt.state       ][INFO    ][29479] Package lsof is already installed
2017-12-19 22:57:08,281 [salt.state       ][INFO    ][29479] Completed state [lsof] at time 22:57:08.280997 duration_in_ms=518.636
2017-12-19 22:57:08,281 [salt.state       ][INFO    ][29479] Running state [keepalived] at time 22:57:08.281190
2017-12-19 22:57:08,281 [salt.state       ][INFO    ][29479] Executing state pkg.installed for keepalived
2017-12-19 22:57:08,284 [salt.state       ][INFO    ][29479] Package keepalived is already installed
2017-12-19 22:57:08,284 [salt.state       ][INFO    ][29479] Completed state [keepalived] at time 22:57:08.284052 duration_in_ms=2.862
2017-12-19 22:57:08,298 [salt.state       ][INFO    ][29479] Running state [/etc/keepalived/keepalived.conf] at time 22:57:08.297593
2017-12-19 22:57:08,298 [salt.state       ][INFO    ][29479] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-19 22:57:08,314 [salt.fileclient  ][INFO    ][29479] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-19 22:57:08,345 [salt.fileclient  ][INFO    ][29479] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-19 22:57:08,349 [salt.state       ][INFO    ][29479] File /etc/keepalived/keepalived.conf is in the correct state
2017-12-19 22:57:08,349 [salt.state       ][INFO    ][29479] Completed state [/etc/keepalived/keepalived.conf] at time 22:57:08.349265 duration_in_ms=51.672
2017-12-19 22:57:08,350 [salt.state       ][INFO    ][29479] Running state [keepalived] at time 22:57:08.349758
2017-12-19 22:57:08,350 [salt.state       ][INFO    ][29479] Executing state service.running for keepalived
2017-12-19 22:57:08,350 [salt.loaded.int.module.cmdmod][INFO    ][29479] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-19 22:57:08,371 [salt.loaded.int.module.cmdmod][INFO    ][29479] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-19 22:57:08,377 [salt.loaded.int.module.cmdmod][INFO    ][29479] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-19 22:57:08,385 [salt.state       ][INFO    ][29479] The service keepalived is already running
2017-12-19 22:57:08,385 [salt.state       ][INFO    ][29479] Completed state [keepalived] at time 22:57:08.385320 duration_in_ms=35.561
2017-12-19 22:57:08,386 [salt.minion      ][INFO    ][29479] Returning information for job: 20171219225706509628
2017-12-19 22:57:14,136 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command pillar.get with jid 20171219225714123318
2017-12-19 22:57:14,155 [salt.minion      ][INFO    ][29506] Starting a new job with PID 29506
2017-12-19 22:57:14,161 [salt.minion      ][INFO    ][29506] Returning information for job: 20171219225714123318
2017-12-19 22:57:52,089 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command state.sls with jid 20171219225752076704
2017-12-19 22:57:52,105 [salt.minion      ][INFO    ][29511] Starting a new job with PID 29511
2017-12-19 22:57:54,542 [salt.state       ][INFO    ][29511] Loading fresh modules for state activity
2017-12-19 22:57:54,562 [salt.fileclient  ][INFO    ][29511] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-19 22:57:54,582 [salt.fileclient  ][INFO    ][29511] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-19 22:57:54,863 [salt.state       ][INFO    ][29511] Running state [attr] at time 22:57:54.862486
2017-12-19 22:57:54,863 [salt.state       ][INFO    ][29511] Executing state pkg.installed for attr
2017-12-19 22:57:54,863 [salt.loaded.int.module.cmdmod][INFO    ][29511] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 22:57:55,172 [salt.state       ][INFO    ][29511] Package attr is already installed
2017-12-19 22:57:55,172 [salt.state       ][INFO    ][29511] Completed state [attr] at time 22:57:55.172425 duration_in_ms=309.938
2017-12-19 22:57:55,173 [salt.state       ][INFO    ][29511] Running state [glusterfs-server] at time 22:57:55.172630
2017-12-19 22:57:55,173 [salt.state       ][INFO    ][29511] Executing state pkg.installed for glusterfs-server
2017-12-19 22:57:55,175 [salt.state       ][INFO    ][29511] Package glusterfs-server is already installed
2017-12-19 22:57:55,176 [salt.state       ][INFO    ][29511] Completed state [glusterfs-server] at time 22:57:55.175562 duration_in_ms=2.932
2017-12-19 22:57:55,176 [salt.state       ][INFO    ][29511] Running state [bc] at time 22:57:55.175705
2017-12-19 22:57:55,176 [salt.state       ][INFO    ][29511] Executing state pkg.installed for bc
2017-12-19 22:57:55,178 [salt.state       ][INFO    ][29511] Package bc is already installed
2017-12-19 22:57:55,179 [salt.state       ][INFO    ][29511] Completed state [bc] at time 22:57:55.178552 duration_in_ms=2.847
2017-12-19 22:57:55,179 [salt.state       ][INFO    ][29511] Running state [glusterfs-server] at time 22:57:55.179209
2017-12-19 22:57:55,179 [salt.state       ][INFO    ][29511] Executing state service.running for glusterfs-server
2017-12-19 22:57:55,180 [salt.loaded.int.module.cmdmod][INFO    ][29511] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-19 22:57:55,196 [salt.loaded.int.module.cmdmod][INFO    ][29511] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-19 22:57:55,203 [salt.loaded.int.module.cmdmod][INFO    ][29511] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-19 22:57:55,213 [salt.state       ][INFO    ][29511] The service glusterfs-server is already running
2017-12-19 22:57:55,213 [salt.state       ][INFO    ][29511] Completed state [glusterfs-server] at time 22:57:55.212802 duration_in_ms=33.593
2017-12-19 22:57:55,214 [salt.state       ][INFO    ][29511] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:57:55.214138
2017-12-19 22:57:55,214 [salt.state       ][INFO    ][29511] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-19 22:57:55,225 [salt.state       ][INFO    ][29511] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-19 22:57:55,225 [salt.state       ][INFO    ][29511] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:57:55.225397 duration_in_ms=11.259
2017-12-19 22:57:55,226 [salt.state       ][INFO    ][29511] Running state [/srv/glusterfs/glance] at time 22:57:55.225545
2017-12-19 22:57:55,226 [salt.state       ][INFO    ][29511] Executing state file.directory for /srv/glusterfs/glance
2017-12-19 22:57:55,226 [salt.state       ][INFO    ][29511] Directory /srv/glusterfs/glance is in the correct state
2017-12-19 22:57:55,226 [salt.state       ][INFO    ][29511] Completed state [/srv/glusterfs/glance] at time 22:57:55.226162 duration_in_ms=0.617
2017-12-19 22:57:55,226 [salt.state       ][INFO    ][29511] Running state [/srv/glusterfs/keystone-keys] at time 22:57:55.226301
2017-12-19 22:57:55,226 [salt.state       ][INFO    ][29511] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-19 22:57:55,227 [salt.state       ][INFO    ][29511] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-19 22:57:55,227 [salt.state       ][INFO    ][29511] Completed state [/srv/glusterfs/keystone-keys] at time 22:57:55.226876 duration_in_ms=0.575
2017-12-19 22:57:55,227 [salt.state       ][INFO    ][29511] Running state [/srv/glusterfs/nova_instances] at time 22:57:55.227012
2017-12-19 22:57:55,227 [salt.state       ][INFO    ][29511] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-19 22:57:55,227 [salt.state       ][INFO    ][29511] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-19 22:57:55,228 [salt.state       ][INFO    ][29511] Completed state [/srv/glusterfs/nova_instances] at time 22:57:55.227602 duration_in_ms=0.59
2017-12-19 22:57:55,228 [salt.state       ][INFO    ][29511] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:57:55.227744
2017-12-19 22:57:55,228 [salt.state       ][INFO    ][29511] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-19 22:57:55,228 [salt.state       ][INFO    ][29511] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-19 22:57:55,228 [salt.state       ][INFO    ][29511] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:57:55.228341 duration_in_ms=0.597
2017-12-19 22:57:55,229 [salt.minion      ][INFO    ][29511] Returning information for job: 20171219225752076704
2017-12-19 22:57:56,357 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command test.ping with jid 20171219225756350127
2017-12-19 22:57:56,373 [salt.minion      ][INFO    ][29535] Starting a new job with PID 29535
2017-12-19 22:57:56,399 [salt.minion      ][INFO    ][29535] Returning information for job: 20171219225756350127
2017-12-19 22:57:56,537 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command state.sls with jid 20171219225756526865
2017-12-19 22:57:56,551 [salt.minion      ][INFO    ][29540] Starting a new job with PID 29540
2017-12-19 22:57:56,988 [salt.state       ][INFO    ][29540] Loading fresh modules for state activity
2017-12-19 22:57:57,009 [salt.fileclient  ][INFO    ][29540] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-19 22:57:57,042 [salt.fileclient  ][INFO    ][29540] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-19 22:57:57,110 [salt.fileclient  ][INFO    ][29540] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-19 22:57:57,128 [salt.fileclient  ][INFO    ][29540] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-19 22:57:57,383 [salt.state       ][INFO    ][29540] Running state [attr] at time 22:57:57.382799
2017-12-19 22:57:57,383 [salt.state       ][INFO    ][29540] Executing state pkg.installed for attr
2017-12-19 22:57:57,383 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-19 22:57:57,640 [salt.state       ][INFO    ][29540] Package attr is already installed
2017-12-19 22:57:57,640 [salt.state       ][INFO    ][29540] Completed state [attr] at time 22:57:57.639721 duration_in_ms=256.922
2017-12-19 22:57:57,640 [salt.state       ][INFO    ][29540] Running state [glusterfs-server] at time 22:57:57.639934
2017-12-19 22:57:57,640 [salt.state       ][INFO    ][29540] Executing state pkg.installed for glusterfs-server
2017-12-19 22:57:57,643 [salt.state       ][INFO    ][29540] Package glusterfs-server is already installed
2017-12-19 22:57:57,643 [salt.state       ][INFO    ][29540] Completed state [glusterfs-server] at time 22:57:57.642817 duration_in_ms=2.882
2017-12-19 22:57:57,643 [salt.state       ][INFO    ][29540] Running state [bc] at time 22:57:57.642958
2017-12-19 22:57:57,643 [salt.state       ][INFO    ][29540] Executing state pkg.installed for bc
2017-12-19 22:57:57,646 [salt.state       ][INFO    ][29540] Package bc is already installed
2017-12-19 22:57:57,646 [salt.state       ][INFO    ][29540] Completed state [bc] at time 22:57:57.645765 duration_in_ms=2.807
2017-12-19 22:57:57,647 [salt.state       ][INFO    ][29540] Running state [glusterfs-server] at time 22:57:57.646553
2017-12-19 22:57:57,647 [salt.state       ][INFO    ][29540] Executing state service.running for glusterfs-server
2017-12-19 22:57:57,647 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-19 22:57:57,663 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-19 22:57:57,668 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-19 22:57:57,677 [salt.state       ][INFO    ][29540] The service glusterfs-server is already running
2017-12-19 22:57:57,677 [salt.state       ][INFO    ][29540] Completed state [glusterfs-server] at time 22:57:57.677427 duration_in_ms=30.873
2017-12-19 22:57:57,679 [salt.state       ][INFO    ][29540] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:57:57.679098
2017-12-19 22:57:57,679 [salt.state       ][INFO    ][29540] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-19 22:57:57,691 [salt.state       ][INFO    ][29540] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-19 22:57:57,691 [salt.state       ][INFO    ][29540] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:57:57.690988 duration_in_ms=11.89
2017-12-19 22:57:57,691 [salt.state       ][INFO    ][29540] Running state [/srv/glusterfs/glance] at time 22:57:57.691179
2017-12-19 22:57:57,691 [salt.state       ][INFO    ][29540] Executing state file.directory for /srv/glusterfs/glance
2017-12-19 22:57:57,692 [salt.state       ][INFO    ][29540] Directory /srv/glusterfs/glance is in the correct state
2017-12-19 22:57:57,692 [salt.state       ][INFO    ][29540] Completed state [/srv/glusterfs/glance] at time 22:57:57.691998 duration_in_ms=0.818
2017-12-19 22:57:57,692 [salt.state       ][INFO    ][29540] Running state [/srv/glusterfs/keystone-keys] at time 22:57:57.692181
2017-12-19 22:57:57,692 [salt.state       ][INFO    ][29540] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-19 22:57:57,693 [salt.state       ][INFO    ][29540] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-19 22:57:57,693 [salt.state       ][INFO    ][29540] Completed state [/srv/glusterfs/keystone-keys] at time 22:57:57.692926 duration_in_ms=0.745
2017-12-19 22:57:57,693 [salt.state       ][INFO    ][29540] Running state [/srv/glusterfs/nova_instances] at time 22:57:57.693108
2017-12-19 22:57:57,693 [salt.state       ][INFO    ][29540] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-19 22:57:57,694 [salt.state       ][INFO    ][29540] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-19 22:57:57,694 [salt.state       ][INFO    ][29540] Completed state [/srv/glusterfs/nova_instances] at time 22:57:57.693849 duration_in_ms=0.742
2017-12-19 22:57:57,694 [salt.state       ][INFO    ][29540] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:57:57.694090
2017-12-19 22:57:57,694 [salt.state       ][INFO    ][29540] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-19 22:57:57,695 [salt.state       ][INFO    ][29540] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-19 22:57:57,695 [salt.state       ][INFO    ][29540] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:57:57.694918 duration_in_ms=0.828
2017-12-19 22:57:57,971 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command ['git', '--version'] in directory '/root'
2017-12-19 22:57:58,067 [salt.state       ][INFO    ][29540] Running state [sleep 5] at time 22:57:58.066928
2017-12-19 22:57:58,067 [salt.state       ][INFO    ][29540] Executing state cmd.wait for sleep 5
2017-12-19 22:57:58,067 [salt.state       ][INFO    ][29540] No changes made for sleep 5
2017-12-19 22:57:58,068 [salt.state       ][INFO    ][29540] Completed state [sleep 5] at time 22:57:58.067607 duration_in_ms=0.681
2017-12-19 22:57:58,068 [salt.state       ][INFO    ][29540] Running state [10.167.4.141] at time 22:57:58.068075
2017-12-19 22:57:58,068 [salt.state       ][INFO    ][29540] Executing state glusterfs.peered for 10.167.4.141
2017-12-19 22:57:58,069 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:58,105 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:58,164 [salt.state       ][INFO    ][29540] Host 10.167.4.141 already peered
2017-12-19 22:57:58,164 [salt.state       ][INFO    ][29540] Completed state [10.167.4.141] at time 22:57:58.164078 duration_in_ms=96.003
2017-12-19 22:57:58,166 [salt.state       ][INFO    ][29540] Running state [10.167.4.142] at time 22:57:58.166315
2017-12-19 22:57:58,167 [salt.state       ][INFO    ][29540] Executing state glusterfs.peered for 10.167.4.142
2017-12-19 22:57:58,167 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:58,177 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:58,232 [salt.state       ][INFO    ][29540] Host 10.167.4.142 already peered
2017-12-19 22:57:58,232 [salt.state       ][INFO    ][29540] Completed state [10.167.4.142] at time 22:57:58.232380 duration_in_ms=66.064
2017-12-19 22:57:58,235 [salt.state       ][INFO    ][29540] Running state [10.167.4.143] at time 22:57:58.234578
2017-12-19 22:57:58,235 [salt.state       ][INFO    ][29540] Executing state glusterfs.peered for 10.167.4.143
2017-12-19 22:57:58,235 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:58,244 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:58,296 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:58,305 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:58,359 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:58,367 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:58,420 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:58,428 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:58,486 [salt.state       ][INFO    ][29540] Peering with localhost is not needed
2017-12-19 22:57:58,486 [salt.state       ][INFO    ][29540] Completed state [10.167.4.143] at time 22:57:58.485969 duration_in_ms=251.391
2017-12-19 22:57:58,487 [salt.state       ][INFO    ][29540] Running state [glance] at time 22:57:58.486725
2017-12-19 22:57:58,487 [salt.state       ][INFO    ][29540] Executing state glusterfs.created for glance
2017-12-19 22:57:58,487 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:58,494 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:58,545 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:58,554 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:58,611 [salt.state       ][INFO    ][29540] Volume glance already exists and is started.
2017-12-19 22:57:58,611 [salt.state       ][INFO    ][29540] Completed state [glance] at time 22:57:58.610741 duration_in_ms=124.015
2017-12-19 22:57:58,614 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:57:58.613938
2017-12-19 22:57:58,614 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 22:57:58,615 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 22:57:58,676 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:58,676 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:57:58.676157 duration_in_ms=62.219
2017-12-19 22:57:58,677 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:57:58.676608
2017-12-19 22:57:58,677 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-19 22:57:58,677 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 22:57:58,727 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:58,728 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:57:58.727504 duration_in_ms=50.896
2017-12-19 22:57:58,728 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:57:58.727926
2017-12-19 22:57:58,728 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-19 22:57:58,729 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 22:57:58,781 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:58,781 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:57:58.781127 duration_in_ms=53.201
2017-12-19 22:57:58,782 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 22:57:58.781597
2017-12-19 22:57:58,782 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 22:57:58,782 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 22:57:58,833 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:58,833 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 22:57:58.833457 duration_in_ms=51.86
2017-12-19 22:57:58,834 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:57:58.833930
2017-12-19 22:57:58,834 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 22:57:58,835 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 22:57:58,886 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:58,887 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:57:58.886642 duration_in_ms=52.71
2017-12-19 22:57:58,887 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:57:58.887140
2017-12-19 22:57:58,887 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-19 22:57:58,888 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 22:57:58,937 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:58,938 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:57:58.937601 duration_in_ms=50.461
2017-12-19 22:57:58,939 [salt.state       ][INFO    ][29540] Running state [glance] at time 22:57:58.938704
2017-12-19 22:57:58,939 [salt.state       ][INFO    ][29540] Executing state glusterfs.started for glance
2017-12-19 22:57:58,939 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:58,947 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:58,994 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:59,002 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:59,057 [salt.state       ][INFO    ][29540] Volume glance is already started
2017-12-19 22:57:59,057 [salt.state       ][INFO    ][29540] Completed state [glance] at time 22:57:59.057283 duration_in_ms=118.579
2017-12-19 22:57:59,058 [salt.state       ][INFO    ][29540] Running state [keystone-keys] at time 22:57:59.058126
2017-12-19 22:57:59,058 [salt.state       ][INFO    ][29540] Executing state glusterfs.created for keystone-keys
2017-12-19 22:57:59,059 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:59,068 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:59,120 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:59,130 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:59,186 [salt.state       ][INFO    ][29540] Volume keystone-keys already exists and is started.
2017-12-19 22:57:59,186 [salt.state       ][INFO    ][29540] Completed state [keystone-keys] at time 22:57:59.186114 duration_in_ms=127.987
2017-12-19 22:57:59,190 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:57:59.189854
2017-12-19 22:57:59,190 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-19 22:57:59,191 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 22:57:59,245 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:59,245 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:57:59.244813 duration_in_ms=54.958
2017-12-19 22:57:59,245 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:57:59.245268
2017-12-19 22:57:59,245 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 22:57:59,246 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 22:57:59,297 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:59,297 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:57:59.297077 duration_in_ms=51.808
2017-12-19 22:57:59,298 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:57:59.297553
2017-12-19 22:57:59,298 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 22:57:59,298 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 22:57:59,350 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:59,350 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:57:59.349900 duration_in_ms=52.345
2017-12-19 22:57:59,350 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:57:59.350394
2017-12-19 22:57:59,351 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 22:57:59,351 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 22:57:59,404 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:59,404 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:57:59.404303 duration_in_ms=53.908
2017-12-19 22:57:59,405 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:57:59.404854
2017-12-19 22:57:59,405 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-19 22:57:59,406 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 22:57:59,458 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:59,459 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:57:59.458671 duration_in_ms=53.817
2017-12-19 22:57:59,459 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:57:59.459132
2017-12-19 22:57:59,459 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-19 22:57:59,460 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 22:57:59,517 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:59,517 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:57:59.516933 duration_in_ms=57.801
2017-12-19 22:57:59,518 [salt.state       ][INFO    ][29540] Running state [keystone-keys] at time 22:57:59.517961
2017-12-19 22:57:59,518 [salt.state       ][INFO    ][29540] Executing state glusterfs.started for keystone-keys
2017-12-19 22:57:59,519 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:59,525 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:59,579 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:59,587 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:59,642 [salt.state       ][INFO    ][29540] Volume keystone-keys is already started
2017-12-19 22:57:59,643 [salt.state       ][INFO    ][29540] Completed state [keystone-keys] at time 22:57:59.642660 duration_in_ms=124.699
2017-12-19 22:57:59,644 [salt.state       ][INFO    ][29540] Running state [nova_instances] at time 22:57:59.643536
2017-12-19 22:57:59,644 [salt.state       ][INFO    ][29540] Executing state glusterfs.created for nova_instances
2017-12-19 22:57:59,644 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:59,653 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:59,703 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:57:59,712 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:57:59,767 [salt.state       ][INFO    ][29540] Volume nova_instances already exists and is started.
2017-12-19 22:57:59,768 [salt.state       ][INFO    ][29540] Completed state [nova_instances] at time 22:57:59.767610 duration_in_ms=124.073
2017-12-19 22:57:59,771 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:57:59.770894
2017-12-19 22:57:59,771 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 22:57:59,772 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 22:57:59,827 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:59,827 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:57:59.826719 duration_in_ms=55.824
2017-12-19 22:57:59,827 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 22:57:59.827187
2017-12-19 22:57:59,827 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-19 22:57:59,828 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 22:57:59,878 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:59,878 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 22:57:59.878431 duration_in_ms=51.244
2017-12-19 22:57:59,879 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 22:57:59.878904
2017-12-19 22:57:59,879 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-19 22:57:59,880 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 22:57:59,931 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:59,931 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 22:57:59.931194 duration_in_ms=52.29
2017-12-19 22:57:59,932 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 22:57:59.931697
2017-12-19 22:57:59,932 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 22:57:59,932 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 22:57:59,988 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:57:59,988 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 22:57:59.987820 duration_in_ms=56.123
2017-12-19 22:57:59,988 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 22:57:59.988266
2017-12-19 22:57:59,988 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-19 22:57:59,989 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 22:58:00,040 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:58:00,040 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 22:58:00.039867 duration_in_ms=51.6
2017-12-19 22:58:00,040 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:58:00.040342
2017-12-19 22:58:00,041 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 22:58:00,041 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 22:58:00,092 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:58:00,092 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:58:00.092239 duration_in_ms=51.897
2017-12-19 22:58:00,093 [salt.state       ][INFO    ][29540] Running state [nova_instances] at time 22:58:00.093321
2017-12-19 22:58:00,094 [salt.state       ][INFO    ][29540] Executing state glusterfs.started for nova_instances
2017-12-19 22:58:00,094 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:00,103 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:00,160 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:00,168 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:00,229 [salt.state       ][INFO    ][29540] Volume nova_instances is already started
2017-12-19 22:58:00,229 [salt.state       ][INFO    ][29540] Completed state [nova_instances] at time 22:58:00.228762 duration_in_ms=135.441
2017-12-19 22:58:00,231 [salt.state       ][INFO    ][29540] Running state [keystone-credential-keys] at time 22:58:00.230506
2017-12-19 22:58:00,231 [salt.state       ][INFO    ][29540] Executing state glusterfs.created for keystone-credential-keys
2017-12-19 22:58:00,232 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:00,239 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:00,290 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:00,299 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:00,360 [salt.state       ][INFO    ][29540] Volume keystone-credential-keys already exists and is started.
2017-12-19 22:58:00,360 [salt.state       ][INFO    ][29540] Completed state [keystone-credential-keys] at time 22:58:00.360076 duration_in_ms=129.569
2017-12-19 22:58:00,364 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:58:00.363691
2017-12-19 22:58:00,364 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-19 22:58:00,364 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-19 22:58:00,420 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:58:00,420 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:58:00.419775 duration_in_ms=56.084
2017-12-19 22:58:00,420 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:58:00.420202
2017-12-19 22:58:00,420 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-19 22:58:00,421 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-19 22:58:00,471 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:58:00,471 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:58:00.471007 duration_in_ms=50.805
2017-12-19 22:58:00,472 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:58:00.471485
2017-12-19 22:58:00,472 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-19 22:58:00,472 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-19 22:58:00,522 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:58:00,523 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:58:00.522514 duration_in_ms=51.028
2017-12-19 22:58:00,523 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:58:00.522967
2017-12-19 22:58:00,523 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-19 22:58:00,524 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-19 22:58:00,574 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:58:00,574 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:58:00.573794 duration_in_ms=50.827
2017-12-19 22:58:00,574 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:58:00.574236
2017-12-19 22:58:00,574 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-19 22:58:00,575 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-19 22:58:00,623 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:58:00,624 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:58:00.623569 duration_in_ms=49.333
2017-12-19 22:58:00,624 [salt.state       ][INFO    ][29540] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:58:00.624032
2017-12-19 22:58:00,624 [salt.state       ][INFO    ][29540] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-19 22:58:00,625 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-19 22:58:00,675 [salt.state       ][INFO    ][29540] unless execution succeeded
2017-12-19 22:58:00,675 [salt.state       ][INFO    ][29540] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:58:00.674910 duration_in_ms=50.878
2017-12-19 22:58:00,676 [salt.state       ][INFO    ][29540] Running state [keystone-credential-keys] at time 22:58:00.676048
2017-12-19 22:58:00,676 [salt.state       ][INFO    ][29540] Executing state glusterfs.started for keystone-credential-keys
2017-12-19 22:58:00,677 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:00,684 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:00,733 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --version' in directory '/root'
2017-12-19 22:58:00,740 [salt.loaded.int.module.cmdmod][INFO    ][29540] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-19 22:58:00,792 [salt.state       ][INFO    ][29540] Volume keystone-credential-keys is already started
2017-12-19 22:58:00,792 [salt.state       ][INFO    ][29540] Completed state [keystone-credential-keys] at time 22:58:00.792326 duration_in_ms=116.278
2017-12-19 22:58:00,794 [salt.minion      ][INFO    ][29540] Returning information for job: 20171219225756526865
2017-12-19 22:58:10,563 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command test.ping with jid 20171219225810552719
2017-12-19 22:58:10,578 [salt.minion      ][INFO    ][30051] Starting a new job with PID 30051
2017-12-19 22:58:10,605 [salt.minion      ][INFO    ][30051] Returning information for job: 20171219225810552719
2017-12-19 22:58:10,743 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command cmd.run with jid 20171219225810731593
2017-12-19 22:58:10,756 [salt.minion      ][INFO    ][30056] Starting a new job with PID 30056
2017-12-19 22:58:10,761 [salt.loaded.int.module.cmdmod][INFO    ][30056] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-19 22:58:10,877 [salt.minion      ][INFO    ][30056] Returning information for job: 20171219225810731593
2017-12-19 23:22:56,505 [salt.utils.schedule][INFO    ][21763] Running scheduled job: __mine_interval
2017-12-19 23:30:01,485 [salt.minion      ][INFO    ][21763] User sudo_ubuntu Executing command cp.push_dir with jid 20171219233001469139
2017-12-19 23:30:01,507 [salt.minion      ][INFO    ][30317] Starting a new job with PID 30317
