2017-09-26 08:18:08,471 [salt.cli.daemons ][WARNING ][2475] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-26 08:35:36,079 [salt.state       ][ERROR   ][3832] No contents found in top file
2017-09-26 08:35:54,933 [salt.utils.parsers][WARNING ][2475] Minion received a SIGTERM. Exiting.
2017-09-26 08:38:09,071 [salt.cli.daemons ][WARNING ][3257] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-26 08:41:01,906 [salt.loaded.int.module.cmdmod][ERROR   ][11458] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-09-26 08:41:01,906 [salt.loaded.int.module.cmdmod][ERROR   ][11458] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-09-26 08:41:01,906 [salt.loaded.int.module.cmdmod][ERROR   ][11458] retcode: 1
2017-09-26 08:41:01,907 [salt.state       ][ERROR   ][11458] {'pid': 16261, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-09-26 08:41:20,803 [py.warnings      ][WARNING ][16302] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-09-26 08:52:04,353 [salt.loaded.int.module.cmdmod][ERROR   ][16302] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-26 08:52:04,354 [salt.loaded.int.module.cmdmod][ERROR   ][16302] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-26 08:52:10,631 [salt.loaded.int.module.cmdmod][ERROR   ][16302] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-26 08:52:10,631 [salt.loaded.int.module.cmdmod][ERROR   ][16302] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-26 08:52:18,309 [salt.loaded.int.module.cmdmod][ERROR   ][16302] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-26 08:52:18,309 [salt.loaded.int.module.cmdmod][ERROR   ][16302] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-26 08:52:27,336 [salt.loaded.int.module.cmdmod][ERROR   ][16302] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-26 08:52:27,336 [salt.loaded.int.module.cmdmod][ERROR   ][16302] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-26 08:52:35,340 [salt.loaded.int.module.cmdmod][ERROR   ][16302] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-26 08:52:35,340 [salt.loaded.int.module.cmdmod][ERROR   ][16302] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-26 08:52:41,389 [salt.loaded.int.module.cmdmod][ERROR   ][16302] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-09-26 08:52:43,534 [salt.loaded.int.module.cmdmod][INFO    ][24214] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-26 08:52:43,541 [salt.loaded.int.module.cmdmod][INFO    ][24214] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-26 08:52:43,548 [salt.loaded.int.module.cmdmod][INFO    ][24214] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-26 08:52:43,554 [salt.utils.parsers][WARNING ][3257] Minion received a SIGTERM. Exiting.
2017-09-26 08:52:43,806 [salt.cli.daemons ][INFO    ][24286] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-odl-ha.local"
2017-09-26 08:52:44,289 [salt.minion      ][INFO    ][24286] Creating minion process manager
2017-09-26 08:52:44,289 [salt.cli.daemons ][WARNING ][24286] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-26 08:52:44,290 [salt.cli.daemons ][INFO    ][24286] The Salt Minion is starting up
2017-09-26 08:52:44,290 [salt.minion      ][INFO    ][24286] Minion is starting as user 'root'
2017-09-26 08:52:44,290 [salt.utils.event ][INFO    ][24286] Starting pull socket on /var/run/salt/minion/minion_event_0607a05f39_pull.ipc
2017-09-26 08:52:45,173 [salt.loaded.int.module.cmdmod][INFO    ][24286] Executing command ['date', '+%z'] in directory '/root'
2017-09-26 08:52:45,183 [salt.utils.schedule][INFO    ][24286] Updating job settings for scheduled job: __mine_interval
2017-09-26 08:52:45,185 [salt.minion      ][INFO    ][24286] Added mine.update to scheduler
2017-09-26 08:52:45,321 [salt.minion      ][INFO    ][24286] Minion is ready to receive requests!
2017-09-26 08:52:46,322 [salt.utils.schedule][INFO    ][24286] Running scheduled job: __mine_interval
2017-09-26 08:52:51,836 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170926085251822688
2017-09-26 08:52:51,850 [salt.minion      ][INFO    ][24389] Starting a new job with PID 24389
2017-09-26 08:52:53,453 [salt.state       ][INFO    ][24389] Loading fresh modules for state activity
2017-09-26 08:52:53,477 [salt.state       ][ERROR   ][24389] No contents found in top file
2017-09-26 08:52:53,478 [salt.utils.extmods][INFO    ][24389] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-26 08:52:53,481 [salt.utils.extmods][INFO    ][24389] Syncing beacons for environment 'base'
2017-09-26 08:52:53,481 [salt.utils.extmods][INFO    ][24389] Loading cache from salt://_beacons, for base)
2017-09-26 08:52:53,481 [salt.fileclient  ][INFO    ][24389] Caching directory '_beacons/' for environment 'base'
2017-09-26 08:52:53,504 [salt.utils.extmods][INFO    ][24389] Syncing modules for environment 'base'
2017-09-26 08:52:53,504 [salt.utils.extmods][INFO    ][24389] Loading cache from salt://_modules, for base)
2017-09-26 08:52:53,504 [salt.fileclient  ][INFO    ][24389] Caching directory '_modules/' for environment 'base'
2017-09-26 08:52:53,599 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-26 08:52:53,657 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-26 08:52:53,735 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-26 08:52:53,870 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-26 08:52:54,005 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-26 08:52:54,097 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-26 08:52:54,165 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-26 08:52:54,238 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-26 08:52:54,276 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-26 08:52:54,385 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-26 08:52:54,462 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-26 08:52:54,552 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-26 08:52:54,607 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-26 08:52:54,718 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-26 08:52:54,803 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-26 08:52:54,853 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-26 08:52:54,935 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-26 08:52:54,946 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-26 08:52:54,956 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-26 08:52:54,979 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-26 08:52:55,074 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-26 08:52:55,126 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-26 08:52:55,142 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-26 08:52:55,239 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-26 08:52:55,283 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-26 08:52:55,335 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-26 08:52:55,422 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-26 08:52:55,499 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-26 08:52:55,603 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-26 08:52:55,663 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-26 08:52:55,705 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-26 08:52:55,823 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-26 08:52:55,826 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-26 08:52:55,826 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-26 08:52:55,891 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-26 08:52:55,936 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-26 08:52:55,967 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-26 08:52:55,1000 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-26 08:52:56,040 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-26 08:52:56,054 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-26 08:52:56,085 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-26 08:52:56,096 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-26 08:52:56,123 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-26 08:52:56,166 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-26 08:52:56,220 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-26 08:52:56,234 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-26 08:52:56,272 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-26 08:52:56,273 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-26 08:52:56,283 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-26 08:52:56,304 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-26 08:52:56,414 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-26 08:52:56,415 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-26 08:52:56,415 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-26 08:52:56,416 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-26 08:52:56,428 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-26 08:52:56,429 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-26 08:52:56,430 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-26 08:52:56,441 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-26 08:52:56,442 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-26 08:52:56,447 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-26 08:52:56,450 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-26 08:52:56,451 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-26 08:52:56,494 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-26 08:52:56,494 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-09-26 08:52:56,495 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-26 08:52:56,495 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-26 08:52:56,501 [salt.utils.extmods][INFO    ][24389] Syncing states for environment 'base'
2017-09-26 08:52:56,501 [salt.utils.extmods][INFO    ][24389] Loading cache from salt://_states, for base)
2017-09-26 08:52:56,501 [salt.fileclient  ][INFO    ][24389] Caching directory '_states/' for environment 'base'
2017-09-26 08:52:56,557 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-26 08:52:56,708 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-26 08:52:56,903 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-26 08:52:57,079 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-26 08:52:57,155 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-26 08:52:57,198 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-26 08:52:57,235 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-26 08:52:57,308 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-26 08:52:57,361 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-26 08:52:57,413 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-26 08:52:57,523 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-26 08:52:57,535 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-26 08:52:57,565 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-26 08:52:57,673 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-26 08:52:57,685 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-26 08:52:57,697 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-26 08:52:57,710 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-26 08:52:57,793 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-26 08:52:57,845 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-26 08:52:58,004 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-26 08:52:58,029 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-26 08:52:58,205 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-26 08:52:58,357 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-26 08:52:58,423 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-26 08:52:58,501 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-26 08:52:58,553 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-26 08:52:58,600 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-26 08:52:58,734 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-26 08:52:58,789 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-26 08:52:58,792 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-26 08:52:58,792 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-26 08:52:58,792 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-26 08:52:58,793 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-26 08:52:58,793 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-26 08:52:58,793 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-26 08:52:58,793 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-26 08:52:58,794 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-26 08:52:58,794 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-26 08:52:58,794 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-26 08:52:58,794 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-26 08:52:58,795 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-26 08:52:58,795 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-26 08:52:58,795 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-26 08:52:58,795 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-26 08:52:58,796 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-26 08:52:58,796 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-26 08:52:58,796 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-26 08:52:58,796 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-26 08:52:58,797 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-26 08:52:58,797 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-26 08:52:58,797 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-26 08:52:58,797 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-26 08:52:58,798 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-26 08:52:58,798 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-26 08:52:58,798 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-26 08:52:58,798 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-26 08:52:58,799 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-26 08:52:58,799 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-26 08:52:58,799 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-26 08:52:58,801 [salt.utils.extmods][INFO    ][24389] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-26 08:52:58,804 [salt.utils.extmods][INFO    ][24389] Syncing sdb for environment 'base'
2017-09-26 08:52:58,804 [salt.utils.extmods][INFO    ][24389] Loading cache from salt://_sdb, for base)
2017-09-26 08:52:58,804 [salt.fileclient  ][INFO    ][24389] Caching directory '_sdb/' for environment 'base'
2017-09-26 08:52:58,838 [salt.utils.extmods][INFO    ][24389] Syncing grains for environment 'base'
2017-09-26 08:52:58,839 [salt.utils.extmods][INFO    ][24389] Loading cache from salt://_grains, for base)
2017-09-26 08:52:58,839 [salt.fileclient  ][INFO    ][24389] Caching directory '_grains/' for environment 'base'
2017-09-26 08:52:58,881 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-26 08:52:58,932 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-26 08:52:58,970 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-26 08:52:58,993 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-26 08:52:59,010 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-26 08:52:59,022 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-26 08:52:59,066 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-26 08:52:59,106 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-26 08:52:59,143 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-26 08:52:59,168 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-26 08:52:59,193 [salt.fileclient  ][INFO    ][24389] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-26 08:52:59,196 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-26 08:52:59,221 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-26 08:52:59,237 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-26 08:52:59,298 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-26 08:52:59,316 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-26 08:52:59,357 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-26 08:52:59,387 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-26 08:52:59,417 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-26 08:52:59,425 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-26 08:52:59,448 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-26 08:52:59,489 [salt.utils.extmods][INFO    ][24389] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-26 08:52:59,509 [salt.utils.extmods][INFO    ][24389] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-26 08:52:59,512 [salt.utils.extmods][INFO    ][24389] Syncing renderers for environment 'base'
2017-09-26 08:52:59,512 [salt.utils.extmods][INFO    ][24389] Loading cache from salt://_renderers, for base)
2017-09-26 08:52:59,512 [salt.fileclient  ][INFO    ][24389] Caching directory '_renderers/' for environment 'base'
2017-09-26 08:52:59,561 [salt.utils.extmods][INFO    ][24389] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-26 08:52:59,563 [salt.utils.extmods][INFO    ][24389] Syncing returners for environment 'base'
2017-09-26 08:52:59,564 [salt.utils.extmods][INFO    ][24389] Loading cache from salt://_returners, for base)
2017-09-26 08:52:59,564 [salt.fileclient  ][INFO    ][24389] Caching directory '_returners/' for environment 'base'
2017-09-26 08:52:59,591 [salt.utils.extmods][INFO    ][24389] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-26 08:52:59,593 [salt.utils.extmods][INFO    ][24389] Syncing output for environment 'base'
2017-09-26 08:52:59,594 [salt.utils.extmods][INFO    ][24389] Loading cache from salt://_output, for base)
2017-09-26 08:52:59,594 [salt.fileclient  ][INFO    ][24389] Caching directory '_output/' for environment 'base'
2017-09-26 08:52:59,624 [salt.utils.extmods][INFO    ][24389] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-26 08:52:59,627 [salt.utils.extmods][INFO    ][24389] Syncing utils for environment 'base'
2017-09-26 08:52:59,627 [salt.utils.extmods][INFO    ][24389] Loading cache from salt://_utils, for base)
2017-09-26 08:52:59,627 [salt.fileclient  ][INFO    ][24389] Caching directory '_utils/' for environment 'base'
2017-09-26 08:52:59,675 [salt.utils.extmods][INFO    ][24389] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-26 08:52:59,677 [salt.utils.extmods][INFO    ][24389] Syncing log_handlers for environment 'base'
2017-09-26 08:52:59,677 [salt.utils.extmods][INFO    ][24389] Loading cache from salt://_log_handlers, for base)
2017-09-26 08:52:59,677 [salt.fileclient  ][INFO    ][24389] Caching directory '_log_handlers/' for environment 'base'
2017-09-26 08:52:59,711 [salt.utils.extmods][INFO    ][24389] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-26 08:52:59,713 [salt.utils.extmods][INFO    ][24389] Syncing proxy for environment 'base'
2017-09-26 08:52:59,713 [salt.utils.extmods][INFO    ][24389] Loading cache from salt://_proxy, for base)
2017-09-26 08:52:59,713 [salt.fileclient  ][INFO    ][24389] Caching directory '_proxy/' for environment 'base'
2017-09-26 08:52:59,742 [salt.utils.extmods][INFO    ][24389] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-26 08:52:59,744 [salt.utils.extmods][INFO    ][24389] Syncing engines for environment 'base'
2017-09-26 08:52:59,744 [salt.utils.extmods][INFO    ][24389] Loading cache from salt://_engines, for base)
2017-09-26 08:52:59,744 [salt.fileclient  ][INFO    ][24389] Caching directory '_engines/' for environment 'base'
2017-09-26 08:52:59,776 [salt.minion      ][INFO    ][24389] Returning information for job: 20170926085251822688
2017-09-26 08:53:02,455 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command state.sls with jid 20170926085302433704
2017-09-26 08:53:02,468 [salt.minion      ][INFO    ][24494] Starting a new job with PID 24494
2017-09-26 08:53:02,915 [salt.state       ][INFO    ][24494] Loading fresh modules for state activity
2017-09-26 08:53:02,941 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-26 08:53:02,959 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-26 08:53:03,057 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-26 08:53:03,122 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-26 08:53:03,136 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-26 08:53:03,161 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-26 08:53:03,211 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-26 08:53:03,242 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-26 08:53:03,283 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-26 08:53:03,301 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-26 08:53:03,313 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-26 08:53:03,328 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-26 08:53:03,334 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-26 08:53:03,391 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-26 08:53:03,405 [py.warnings      ][WARNING ][24494] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-09-26 08:53:03,405 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'salt-minion --version' in directory '/root'
2017-09-26 08:53:03,654 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-26 08:53:03,673 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-26 08:53:03,714 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-26 08:53:03,727 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-26 08:53:03,773 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-26 08:53:03,819 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-26 08:53:03,873 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-26 08:53:03,894 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-26 08:53:04,032 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-26 08:53:04,051 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-26 08:53:04,104 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-26 08:53:04,122 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-26 08:53:04,135 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-26 08:53:04,195 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-26 08:53:04,202 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-26 08:53:04,225 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-26 08:53:04,238 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'salt-minion --version' in directory '/root'
2017-09-26 08:53:04,533 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-26 08:53:04,553 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-26 08:53:04,566 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-26 08:53:04,577 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-26 08:53:04,631 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-26 08:53:04,665 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-26 08:53:04,729 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-26 08:53:04,826 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-26 08:53:05,234 [salt.state       ][INFO    ][24494] Running state [salt-minion] at time 08:53:05.233929
2017-09-26 08:53:05,234 [salt.state       ][INFO    ][24494] Executing state pkg.installed for salt-minion
2017-09-26 08:53:05,235 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-26 08:53:05,493 [salt.state       ][INFO    ][24494] Package salt-minion is already installed
2017-09-26 08:53:05,493 [salt.state       ][INFO    ][24494] Completed state [salt-minion] at time 08:53:05.492744 duration_in_ms=258.815
2017-09-26 08:53:05,493 [salt.state       ][INFO    ][24494] Running state [python-yaml] at time 08:53:05.492951
2017-09-26 08:53:05,493 [salt.state       ][INFO    ][24494] Executing state pkg.installed for python-yaml
2017-09-26 08:53:05,496 [salt.state       ][INFO    ][24494] Package python-yaml is already installed
2017-09-26 08:53:05,508 [salt.state       ][INFO    ][24494] Completed state [python-yaml] at time 08:53:05.507710 duration_in_ms=14.758
2017-09-26 08:53:05,508 [salt.state       ][INFO    ][24494] Running state [python-psutil] at time 08:53:05.508080
2017-09-26 08:53:05,508 [salt.state       ][INFO    ][24494] Executing state pkg.installed for python-psutil
2017-09-26 08:53:05,511 [salt.state       ][INFO    ][24494] Package python-psutil is already installed
2017-09-26 08:53:05,511 [salt.state       ][INFO    ][24494] Completed state [python-psutil] at time 08:53:05.510889 duration_in_ms=2.808
2017-09-26 08:53:05,511 [salt.state       ][INFO    ][24494] Running state [python-m2crypto] at time 08:53:05.511055
2017-09-26 08:53:05,511 [salt.state       ][INFO    ][24494] Executing state pkg.installed for python-m2crypto
2017-09-26 08:53:05,514 [salt.state       ][INFO    ][24494] Package python-m2crypto is already installed
2017-09-26 08:53:05,514 [salt.state       ][INFO    ][24494] Completed state [python-m2crypto] at time 08:53:05.513780 duration_in_ms=2.724
2017-09-26 08:53:05,515 [salt.state       ][INFO    ][24494] Running state [/etc/salt/minion.d/minion.conf] at time 08:53:05.515212
2017-09-26 08:53:05,515 [salt.state       ][INFO    ][24494] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-26 08:53:05,537 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-26 08:53:05,595 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-26 08:53:05,636 [salt.fileclient  ][INFO    ][24494] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-26 08:53:05,668 [salt.state       ][INFO    ][24494] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-26 08:53:05,668 [salt.state       ][INFO    ][24494] Completed state [/etc/salt/minion.d/minion.conf] at time 08:53:05.667829 duration_in_ms=152.616
2017-09-26 08:53:05,668 [salt.state       ][INFO    ][24494] Running state [/etc/salt/minion.d/_virt.conf] at time 08:53:05.668121
2017-09-26 08:53:05,668 [salt.state       ][INFO    ][24494] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-26 08:53:05,765 [salt.state       ][INFO    ][24494] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-26 08:53:05,765 [salt.state       ][INFO    ][24494] Completed state [/etc/salt/minion.d/_virt.conf] at time 08:53:05.765394 duration_in_ms=97.273
2017-09-26 08:53:05,766 [salt.state       ][INFO    ][24494] Running state [salt-minion] at time 08:53:05.766442
2017-09-26 08:53:05,767 [salt.state       ][INFO    ][24494] Executing state service.running for salt-minion
2017-09-26 08:53:05,767 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-26 08:53:05,786 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-26 08:53:05,795 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-26 08:53:05,803 [salt.state       ][INFO    ][24494] The service salt-minion is already running
2017-09-26 08:53:05,803 [salt.state       ][INFO    ][24494] Completed state [salt-minion] at time 08:53:05.803273 duration_in_ms=36.831
2017-09-26 08:53:05,805 [salt.state       ][INFO    ][24494] Running state [/etc/salt/grains.d] at time 08:53:05.804499
2017-09-26 08:53:05,805 [salt.state       ][INFO    ][24494] Executing state file.directory for /etc/salt/grains.d
2017-09-26 08:53:05,805 [salt.state       ][INFO    ][24494] Directory /etc/salt/grains.d is in the correct state
2017-09-26 08:53:05,806 [salt.state       ][INFO    ][24494] Completed state [/etc/salt/grains.d] at time 08:53:05.805499 duration_in_ms=1.0
2017-09-26 08:53:05,806 [salt.state       ][INFO    ][24494] Running state [/etc/salt/grains] at time 08:53:05.805983
2017-09-26 08:53:05,806 [salt.state       ][INFO    ][24494] Executing state file.managed for /etc/salt/grains
2017-09-26 08:53:05,807 [salt.state       ][INFO    ][24494] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-26 08:53:05,807 [salt.state       ][INFO    ][24494] Completed state [/etc/salt/grains] at time 08:53:05.806739 duration_in_ms=0.757
2017-09-26 08:53:05,807 [salt.state       ][INFO    ][24494] Running state [/etc/salt/grains.d/placeholder] at time 08:53:05.807044
2017-09-26 08:53:05,807 [salt.state       ][INFO    ][24494] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-26 08:53:05,808 [salt.state       ][INFO    ][24494] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-26 08:53:05,808 [salt.state       ][INFO    ][24494] Completed state [/etc/salt/grains.d/placeholder] at time 08:53:05.807758 duration_in_ms=0.714
2017-09-26 08:53:05,808 [salt.state       ][INFO    ][24494] Running state [/etc/salt/grains.d/sphinx] at time 08:53:05.808068
2017-09-26 08:53:05,808 [salt.state       ][INFO    ][24494] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-26 08:53:05,902 [salt.state       ][INFO    ][24494] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.142
               - 127.0.0.1
               - 192.168.11.253
-              - 192.168.122.1
         system:
           name: System
           param:

2017-09-26 08:53:05,902 [salt.state       ][INFO    ][24494] Completed state [/etc/salt/grains.d/sphinx] at time 08:53:05.902321 duration_in_ms=94.253
2017-09-26 08:53:05,903 [salt.state       ][INFO    ][24494] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:53:05.902837
2017-09-26 08:53:05,903 [salt.state       ][INFO    ][24494] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-26 08:53:05,903 [salt.state       ][INFO    ][24494] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-26 08:53:05,904 [salt.state       ][INFO    ][24494] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:53:05.903786 duration_in_ms=0.948
2017-09-26 08:53:05,904 [salt.state       ][INFO    ][24494] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:53:05.904003
2017-09-26 08:53:05,904 [salt.state       ][INFO    ][24494] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-26 08:53:05,905 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-09-26 08:53:06,001 [salt.state       ][INFO    ][24494] {'pid': 24543, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-09-26 08:53:06,001 [salt.state       ][INFO    ][24494] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:53:06.001241 duration_in_ms=97.237
2017-09-26 08:53:06,002 [salt.state       ][INFO    ][24494] Running state [/etc/salt/grains.d/dns_records] at time 08:53:06.001813
2017-09-26 08:53:06,002 [salt.state       ][INFO    ][24494] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-26 08:53:06,030 [salt.state       ][INFO    ][24494] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-26 08:53:06,030 [salt.state       ][INFO    ][24494] Completed state [/etc/salt/grains.d/dns_records] at time 08:53:06.029785 duration_in_ms=27.972
2017-09-26 08:53:06,030 [salt.state       ][INFO    ][24494] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:53:06.030317
2017-09-26 08:53:06,031 [salt.state       ][INFO    ][24494] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-26 08:53:06,031 [salt.state       ][INFO    ][24494] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-26 08:53:06,031 [salt.state       ][INFO    ][24494] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:53:06.030840 duration_in_ms=0.524
2017-09-26 08:53:06,031 [salt.state       ][INFO    ][24494] Running state [/etc/salt/grains.d/salt] at time 08:53:06.031123
2017-09-26 08:53:06,031 [salt.state       ][INFO    ][24494] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-26 08:53:06,144 [salt.state       ][INFO    ][24494] File /etc/salt/grains.d/salt is in the correct state
2017-09-26 08:53:06,144 [salt.state       ][INFO    ][24494] Completed state [/etc/salt/grains.d/salt] at time 08:53:06.143963 duration_in_ms=112.841
2017-09-26 08:53:06,145 [salt.state       ][INFO    ][24494] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:53:06.144481
2017-09-26 08:53:06,145 [salt.state       ][INFO    ][24494] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-26 08:53:06,145 [salt.state       ][INFO    ][24494] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-26 08:53:06,145 [salt.state       ][INFO    ][24494] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:53:06.145086 duration_in_ms=0.605
2017-09-26 08:53:06,146 [salt.state       ][INFO    ][24494] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:53:06.146377
2017-09-26 08:53:06,147 [salt.state       ][INFO    ][24494] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-26 08:53:06,147 [salt.state       ][INFO    ][24494] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-26 08:53:06,147 [salt.state       ][INFO    ][24494] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:53:06.147028 duration_in_ms=0.651
2017-09-26 08:53:06,147 [salt.state       ][INFO    ][24494] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:53:06.147184
2017-09-26 08:53:06,147 [salt.state       ][INFO    ][24494] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-26 08:53:06,149 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-09-26 08:53:06,158 [salt.state       ][INFO    ][24494] {'pid': 24545, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-09-26 08:53:06,158 [salt.state       ][INFO    ][24494] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:53:06.158288 duration_in_ms=11.104
2017-09-26 08:53:06,159 [salt.state       ][INFO    ][24494] Running state [mine.update] at time 08:53:06.159062
2017-09-26 08:53:06,159 [salt.state       ][INFO    ][24494] Executing state module.wait for mine.update
2017-09-26 08:53:06,160 [salt.state       ][INFO    ][24494] No changes made for mine.update
2017-09-26 08:53:06,160 [salt.state       ][INFO    ][24494] Completed state [mine.update] at time 08:53:06.159729 duration_in_ms=0.667
2017-09-26 08:53:06,160 [salt.state       ][INFO    ][24494] Running state [mine.update] at time 08:53:06.159905
2017-09-26 08:53:06,160 [salt.state       ][INFO    ][24494] Executing state module.mod_watch for mine.update
2017-09-26 08:53:06,683 [salt.state       ][INFO    ][24494] {'ret': True}
2017-09-26 08:53:06,683 [salt.state       ][INFO    ][24494] Completed state [mine.update] at time 08:53:06.682854 duration_in_ms=522.948
2017-09-26 08:53:06,683 [salt.state       ][INFO    ][24494] Running state [ca-certificates] at time 08:53:06.683125
2017-09-26 08:53:06,683 [salt.state       ][INFO    ][24494] Executing state pkg.installed for ca-certificates
2017-09-26 08:53:06,687 [salt.state       ][INFO    ][24494] Package ca-certificates is already installed
2017-09-26 08:53:06,687 [salt.state       ][INFO    ][24494] Completed state [ca-certificates] at time 08:53:06.686755 duration_in_ms=3.63
2017-09-26 08:53:06,687 [salt.state       ][INFO    ][24494] Running state [update-ca-certificates] at time 08:53:06.687338
2017-09-26 08:53:06,688 [salt.state       ][INFO    ][24494] Executing state cmd.wait for update-ca-certificates
2017-09-26 08:53:06,688 [salt.state       ][INFO    ][24494] No changes made for update-ca-certificates
2017-09-26 08:53:06,688 [salt.state       ][INFO    ][24494] Completed state [update-ca-certificates] at time 08:53:06.687953 duration_in_ms=0.615
2017-09-26 08:53:06,688 [salt.state       ][INFO    ][24494] Running state [libvirt-dev] at time 08:53:06.688142
2017-09-26 08:53:06,688 [salt.state       ][INFO    ][24494] Executing state pkg.installed for libvirt-dev
2017-09-26 08:53:06,691 [salt.state       ][INFO    ][24494] Package libvirt-dev is already installed
2017-09-26 08:53:06,691 [salt.state       ][INFO    ][24494] Completed state [libvirt-dev] at time 08:53:06.691311 duration_in_ms=3.17
2017-09-26 08:53:06,692 [salt.state       ][INFO    ][24494] Running state [pkg-config] at time 08:53:06.691495
2017-09-26 08:53:06,692 [salt.state       ][INFO    ][24494] Executing state pkg.installed for pkg-config
2017-09-26 08:53:06,694 [salt.state       ][INFO    ][24494] Package pkg-config is already installed
2017-09-26 08:53:06,695 [salt.state       ][INFO    ][24494] Completed state [pkg-config] at time 08:53:06.694545 duration_in_ms=3.051
2017-09-26 08:53:06,695 [salt.state       ][INFO    ][24494] Running state [virtng.init] at time 08:53:06.694759
2017-09-26 08:53:06,695 [salt.state       ][INFO    ][24494] Executing state module.run for virtng.init
2017-09-26 08:53:06,748 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command ['git', '--version'] in directory '/root'
2017-09-26 08:53:06,856 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:53:06,876 [salt.state       ][INFO    ][24494] unless execution succeeded
2017-09-26 08:53:06,876 [salt.state       ][INFO    ][24494] Completed state [virtng.init] at time 08:53:06.875979 duration_in_ms=181.219
2017-09-26 08:53:06,876 [salt.state       ][INFO    ][24494] Running state [virt.set_autostart] at time 08:53:06.876257
2017-09-26 08:53:06,877 [salt.state       ][INFO    ][24494] Executing state module.run for virt.set_autostart
2017-09-26 08:53:06,879 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:53:06,896 [salt.state       ][INFO    ][24494] unless execution succeeded
2017-09-26 08:53:06,896 [salt.state       ][INFO    ][24494] Completed state [virt.set_autostart] at time 08:53:06.895789 duration_in_ms=19.531
2017-09-26 08:53:06,896 [salt.state       ][INFO    ][24494] Running state [virtng.init] at time 08:53:06.896040
2017-09-26 08:53:06,896 [salt.state       ][INFO    ][24494] Executing state module.run for virtng.init
2017-09-26 08:53:06,898 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:53:06,958 [salt.state       ][INFO    ][24494] unless execution succeeded
2017-09-26 08:53:06,959 [salt.state       ][INFO    ][24494] Completed state [virtng.init] at time 08:53:06.958493 duration_in_ms=62.453
2017-09-26 08:53:06,959 [salt.state       ][INFO    ][24494] Running state [virt.set_autostart] at time 08:53:06.958761
2017-09-26 08:53:06,959 [salt.state       ][INFO    ][24494] Executing state module.run for virt.set_autostart
2017-09-26 08:53:06,961 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:53:06,977 [salt.state       ][INFO    ][24494] unless execution succeeded
2017-09-26 08:53:06,977 [salt.state       ][INFO    ][24494] Completed state [virt.set_autostart] at time 08:53:06.977358 duration_in_ms=18.595
2017-09-26 08:53:06,978 [salt.state       ][INFO    ][24494] Running state [virtng.init] at time 08:53:06.977594
2017-09-26 08:53:06,978 [salt.state       ][INFO    ][24494] Executing state module.run for virtng.init
2017-09-26 08:53:06,980 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:53:06,996 [salt.state       ][INFO    ][24494] unless execution succeeded
2017-09-26 08:53:06,996 [salt.state       ][INFO    ][24494] Completed state [virtng.init] at time 08:53:06.995897 duration_in_ms=18.303
2017-09-26 08:53:06,996 [salt.state       ][INFO    ][24494] Running state [virt.set_autostart] at time 08:53:06.996129
2017-09-26 08:53:06,996 [salt.state       ][INFO    ][24494] Executing state module.run for virt.set_autostart
2017-09-26 08:53:06,998 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:53:07,014 [salt.state       ][INFO    ][24494] unless execution succeeded
2017-09-26 08:53:07,014 [salt.state       ][INFO    ][24494] Completed state [virt.set_autostart] at time 08:53:07.013908 duration_in_ms=17.779
2017-09-26 08:53:07,014 [salt.state       ][INFO    ][24494] Running state [virtng.init] at time 08:53:07.014136
2017-09-26 08:53:07,014 [salt.state       ][INFO    ][24494] Executing state module.run for virtng.init
2017-09-26 08:53:07,016 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:53:07,031 [salt.state       ][INFO    ][24494] unless execution succeeded
2017-09-26 08:53:07,049 [salt.state       ][INFO    ][24494] Completed state [virtng.init] at time 08:53:07.048839 duration_in_ms=34.703
2017-09-26 08:53:07,049 [salt.state       ][INFO    ][24494] Running state [virt.set_autostart] at time 08:53:07.049119
2017-09-26 08:53:07,049 [salt.state       ][INFO    ][24494] Executing state module.run for virt.set_autostart
2017-09-26 08:53:07,051 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:53:07,066 [salt.state       ][INFO    ][24494] unless execution succeeded
2017-09-26 08:53:07,067 [salt.state       ][INFO    ][24494] Completed state [virt.set_autostart] at time 08:53:07.066538 duration_in_ms=17.418
2017-09-26 08:53:07,067 [salt.state       ][INFO    ][24494] Running state [virtng.init] at time 08:53:07.066785
2017-09-26 08:53:07,067 [salt.state       ][INFO    ][24494] Executing state module.run for virtng.init
2017-09-26 08:53:07,069 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:53:07,084 [salt.state       ][INFO    ][24494] unless execution succeeded
2017-09-26 08:53:07,084 [salt.state       ][INFO    ][24494] Completed state [virtng.init] at time 08:53:07.084084 duration_in_ms=17.299
2017-09-26 08:53:07,084 [salt.state       ][INFO    ][24494] Running state [virt.set_autostart] at time 08:53:07.084313
2017-09-26 08:53:07,085 [salt.state       ][INFO    ][24494] Executing state module.run for virt.set_autostart
2017-09-26 08:53:07,086 [salt.loaded.int.module.cmdmod][INFO    ][24494] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:53:07,101 [salt.state       ][INFO    ][24494] unless execution succeeded
2017-09-26 08:53:07,102 [salt.state       ][INFO    ][24494] Completed state [virt.set_autostart] at time 08:53:07.101466 duration_in_ms=17.152
2017-09-26 08:53:07,104 [salt.minion      ][INFO    ][24494] Returning information for job: 20170926085302433704
2017-09-26 08:56:56,088 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command state.sls with jid 20170926085656070234
2017-09-26 08:56:56,102 [salt.minion      ][INFO    ][24662] Starting a new job with PID 24662
2017-09-26 08:56:57,817 [salt.state       ][INFO    ][24662] Loading fresh modules for state activity
2017-09-26 08:56:57,844 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-26 08:56:57,909 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-26 08:56:57,936 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-26 08:56:58,003 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-26 08:56:58,017 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-26 08:56:58,043 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-26 08:56:58,094 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-26 08:56:58,112 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-26 08:56:58,154 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-26 08:56:58,172 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-26 08:56:58,219 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-26 08:56:58,243 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-26 08:56:58,250 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-26 08:56:58,272 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-26 08:56:58,286 [py.warnings      ][WARNING ][24662] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-09-26 08:56:58,286 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'salt-minion --version' in directory '/root'
2017-09-26 08:56:58,530 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-26 08:56:58,544 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-26 08:56:58,553 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-26 08:56:58,562 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-26 08:56:58,604 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-26 08:56:58,635 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-26 08:56:58,688 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-26 08:56:58,706 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-26 08:56:58,755 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-26 08:56:58,772 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-26 08:56:58,812 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-26 08:56:58,832 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-26 08:56:58,845 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-26 08:56:58,860 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-26 08:56:58,866 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-26 08:56:58,888 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-26 08:56:58,901 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'salt-minion --version' in directory '/root'
2017-09-26 08:56:59,159 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-26 08:56:59,177 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-26 08:56:59,188 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-26 08:56:59,201 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-26 08:56:59,262 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-26 08:56:59,305 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-26 08:56:59,367 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-26 08:56:59,426 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-26 08:56:59,728 [salt.state       ][INFO    ][24662] Running state [salt-minion] at time 08:56:59.728175
2017-09-26 08:56:59,729 [salt.state       ][INFO    ][24662] Executing state pkg.installed for salt-minion
2017-09-26 08:56:59,729 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-26 08:57:00,024 [salt.state       ][INFO    ][24662] Package salt-minion is already installed
2017-09-26 08:57:00,025 [salt.state       ][INFO    ][24662] Completed state [salt-minion] at time 08:57:00.024663 duration_in_ms=296.487
2017-09-26 08:57:00,025 [salt.state       ][INFO    ][24662] Running state [python-yaml] at time 08:57:00.024901
2017-09-26 08:57:00,025 [salt.state       ][INFO    ][24662] Executing state pkg.installed for python-yaml
2017-09-26 08:57:00,028 [salt.state       ][INFO    ][24662] Package python-yaml is already installed
2017-09-26 08:57:00,028 [salt.state       ][INFO    ][24662] Completed state [python-yaml] at time 08:57:00.027908 duration_in_ms=3.007
2017-09-26 08:57:00,028 [salt.state       ][INFO    ][24662] Running state [python-psutil] at time 08:57:00.028084
2017-09-26 08:57:00,028 [salt.state       ][INFO    ][24662] Executing state pkg.installed for python-psutil
2017-09-26 08:57:00,031 [salt.state       ][INFO    ][24662] Package python-psutil is already installed
2017-09-26 08:57:00,031 [salt.state       ][INFO    ][24662] Completed state [python-psutil] at time 08:57:00.031050 duration_in_ms=2.966
2017-09-26 08:57:00,031 [salt.state       ][INFO    ][24662] Running state [python-m2crypto] at time 08:57:00.031219
2017-09-26 08:57:00,031 [salt.state       ][INFO    ][24662] Executing state pkg.installed for python-m2crypto
2017-09-26 08:57:00,034 [salt.state       ][INFO    ][24662] Package python-m2crypto is already installed
2017-09-26 08:57:00,034 [salt.state       ][INFO    ][24662] Completed state [python-m2crypto] at time 08:57:00.034103 duration_in_ms=2.883
2017-09-26 08:57:00,036 [salt.state       ][INFO    ][24662] Running state [/etc/salt/minion.d/minion.conf] at time 08:57:00.035722
2017-09-26 08:57:00,036 [salt.state       ][INFO    ][24662] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-26 08:57:00,064 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-26 08:57:00,110 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-26 08:57:00,153 [salt.fileclient  ][INFO    ][24662] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-26 08:57:00,186 [salt.state       ][INFO    ][24662] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-26 08:57:00,186 [salt.state       ][INFO    ][24662] Completed state [/etc/salt/minion.d/minion.conf] at time 08:57:00.186162 duration_in_ms=150.44
2017-09-26 08:57:00,187 [salt.state       ][INFO    ][24662] Running state [/etc/salt/minion.d/_virt.conf] at time 08:57:00.186483
2017-09-26 08:57:00,187 [salt.state       ][INFO    ][24662] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-26 08:57:00,189 [salt.state       ][INFO    ][24662] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-26 08:57:00,189 [salt.state       ][INFO    ][24662] Completed state [/etc/salt/minion.d/_virt.conf] at time 08:57:00.188983 duration_in_ms=2.499
2017-09-26 08:57:00,190 [salt.state       ][INFO    ][24662] Running state [salt-minion] at time 08:57:00.190014
2017-09-26 08:57:00,190 [salt.state       ][INFO    ][24662] Executing state service.running for salt-minion
2017-09-26 08:57:00,191 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-26 08:57:00,208 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-26 08:57:00,216 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-26 08:57:00,224 [salt.state       ][INFO    ][24662] The service salt-minion is already running
2017-09-26 08:57:00,224 [salt.state       ][INFO    ][24662] Completed state [salt-minion] at time 08:57:00.224176 duration_in_ms=34.161
2017-09-26 08:57:00,225 [salt.state       ][INFO    ][24662] Running state [/etc/salt/grains.d] at time 08:57:00.225222
2017-09-26 08:57:00,225 [salt.state       ][INFO    ][24662] Executing state file.directory for /etc/salt/grains.d
2017-09-26 08:57:00,226 [salt.state       ][INFO    ][24662] Directory /etc/salt/grains.d is in the correct state
2017-09-26 08:57:00,226 [salt.state       ][INFO    ][24662] Completed state [/etc/salt/grains.d] at time 08:57:00.226103 duration_in_ms=0.882
2017-09-26 08:57:00,227 [salt.state       ][INFO    ][24662] Running state [/etc/salt/grains] at time 08:57:00.226543
2017-09-26 08:57:00,227 [salt.state       ][INFO    ][24662] Executing state file.managed for /etc/salt/grains
2017-09-26 08:57:00,227 [salt.state       ][INFO    ][24662] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-26 08:57:00,227 [salt.state       ][INFO    ][24662] Completed state [/etc/salt/grains] at time 08:57:00.227232 duration_in_ms=0.689
2017-09-26 08:57:00,228 [salt.state       ][INFO    ][24662] Running state [/etc/salt/grains.d/placeholder] at time 08:57:00.227492
2017-09-26 08:57:00,228 [salt.state       ][INFO    ][24662] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-26 08:57:00,228 [salt.state       ][INFO    ][24662] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-26 08:57:00,228 [salt.state       ][INFO    ][24662] Completed state [/etc/salt/grains.d/placeholder] at time 08:57:00.228062 duration_in_ms=0.57
2017-09-26 08:57:00,228 [salt.state       ][INFO    ][24662] Running state [/etc/salt/grains.d/sphinx] at time 08:57:00.228329
2017-09-26 08:57:00,229 [salt.state       ][INFO    ][24662] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-26 08:57:00,235 [salt.state       ][INFO    ][24662] File /etc/salt/grains.d/sphinx is in the correct state
2017-09-26 08:57:00,235 [salt.state       ][INFO    ][24662] Completed state [/etc/salt/grains.d/sphinx] at time 08:57:00.234732 duration_in_ms=6.402
2017-09-26 08:57:00,235 [salt.state       ][INFO    ][24662] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:57:00.235176
2017-09-26 08:57:00,235 [salt.state       ][INFO    ][24662] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-26 08:57:00,236 [salt.state       ][INFO    ][24662] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-26 08:57:00,236 [salt.state       ][INFO    ][24662] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:57:00.235647 duration_in_ms=0.471
2017-09-26 08:57:00,236 [salt.state       ][INFO    ][24662] Running state [/etc/salt/grains.d/dns_records] at time 08:57:00.235906
2017-09-26 08:57:00,236 [salt.state       ][INFO    ][24662] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-26 08:57:00,241 [salt.state       ][INFO    ][24662] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-26 08:57:00,241 [salt.state       ][INFO    ][24662] Completed state [/etc/salt/grains.d/dns_records] at time 08:57:00.240807 duration_in_ms=4.9
2017-09-26 08:57:00,241 [salt.state       ][INFO    ][24662] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:57:00.241266
2017-09-26 08:57:00,241 [salt.state       ][INFO    ][24662] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-26 08:57:00,242 [salt.state       ][INFO    ][24662] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-26 08:57:00,242 [salt.state       ][INFO    ][24662] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:57:00.241720 duration_in_ms=0.454
2017-09-26 08:57:00,242 [salt.state       ][INFO    ][24662] Running state [/etc/salt/grains.d/salt] at time 08:57:00.241978
2017-09-26 08:57:00,242 [salt.state       ][INFO    ][24662] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-26 08:57:00,247 [salt.state       ][INFO    ][24662] File /etc/salt/grains.d/salt is in the correct state
2017-09-26 08:57:00,247 [salt.state       ][INFO    ][24662] Completed state [/etc/salt/grains.d/salt] at time 08:57:00.246958 duration_in_ms=4.979
2017-09-26 08:57:00,247 [salt.state       ][INFO    ][24662] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:57:00.247389
2017-09-26 08:57:00,248 [salt.state       ][INFO    ][24662] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-26 08:57:00,248 [salt.state       ][INFO    ][24662] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-26 08:57:00,248 [salt.state       ][INFO    ][24662] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:57:00.247847 duration_in_ms=0.458
2017-09-26 08:57:00,249 [salt.state       ][INFO    ][24662] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:57:00.248994
2017-09-26 08:57:00,249 [salt.state       ][INFO    ][24662] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-26 08:57:00,249 [salt.state       ][INFO    ][24662] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-26 08:57:00,249 [salt.state       ][INFO    ][24662] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:57:00.249454 duration_in_ms=0.461
2017-09-26 08:57:00,250 [salt.state       ][INFO    ][24662] Running state [mine.update] at time 08:57:00.249836
2017-09-26 08:57:00,250 [salt.state       ][INFO    ][24662] Executing state module.wait for mine.update
2017-09-26 08:57:00,250 [salt.state       ][INFO    ][24662] No changes made for mine.update
2017-09-26 08:57:00,250 [salt.state       ][INFO    ][24662] Completed state [mine.update] at time 08:57:00.250249 duration_in_ms=0.412
2017-09-26 08:57:00,250 [salt.state       ][INFO    ][24662] Running state [ca-certificates] at time 08:57:00.250379
2017-09-26 08:57:00,251 [salt.state       ][INFO    ][24662] Executing state pkg.installed for ca-certificates
2017-09-26 08:57:00,254 [salt.state       ][INFO    ][24662] Package ca-certificates is already installed
2017-09-26 08:57:00,254 [salt.state       ][INFO    ][24662] Completed state [ca-certificates] at time 08:57:00.253612 duration_in_ms=3.232
2017-09-26 08:57:00,254 [salt.state       ][INFO    ][24662] Running state [update-ca-certificates] at time 08:57:00.254015
2017-09-26 08:57:00,254 [salt.state       ][INFO    ][24662] Executing state cmd.wait for update-ca-certificates
2017-09-26 08:57:00,254 [salt.state       ][INFO    ][24662] No changes made for update-ca-certificates
2017-09-26 08:57:00,254 [salt.state       ][INFO    ][24662] Completed state [update-ca-certificates] at time 08:57:00.254452 duration_in_ms=0.438
2017-09-26 08:57:00,255 [salt.state       ][INFO    ][24662] Running state [libvirt-dev] at time 08:57:00.254590
2017-09-26 08:57:00,255 [salt.state       ][INFO    ][24662] Executing state pkg.installed for libvirt-dev
2017-09-26 08:57:00,257 [salt.state       ][INFO    ][24662] Package libvirt-dev is already installed
2017-09-26 08:57:00,257 [salt.state       ][INFO    ][24662] Completed state [libvirt-dev] at time 08:57:00.257401 duration_in_ms=2.811
2017-09-26 08:57:00,258 [salt.state       ][INFO    ][24662] Running state [pkg-config] at time 08:57:00.257536
2017-09-26 08:57:00,258 [salt.state       ][INFO    ][24662] Executing state pkg.installed for pkg-config
2017-09-26 08:57:00,260 [salt.state       ][INFO    ][24662] Package pkg-config is already installed
2017-09-26 08:57:00,260 [salt.state       ][INFO    ][24662] Completed state [pkg-config] at time 08:57:00.260368 duration_in_ms=2.833
2017-09-26 08:57:00,261 [salt.state       ][INFO    ][24662] Running state [virtng.init] at time 08:57:00.260506
2017-09-26 08:57:00,261 [salt.state       ][INFO    ][24662] Executing state module.run for virtng.init
2017-09-26 08:57:00,296 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command ['git', '--version'] in directory '/root'
2017-09-26 08:57:00,383 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:57:00,403 [salt.state       ][INFO    ][24662] unless execution succeeded
2017-09-26 08:57:00,403 [salt.state       ][INFO    ][24662] Completed state [virtng.init] at time 08:57:00.402827 duration_in_ms=142.319
2017-09-26 08:57:00,403 [salt.state       ][INFO    ][24662] Running state [virt.set_autostart] at time 08:57:00.403116
2017-09-26 08:57:00,403 [salt.state       ][INFO    ][24662] Executing state module.run for virt.set_autostart
2017-09-26 08:57:00,405 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:57:00,423 [salt.state       ][INFO    ][24662] unless execution succeeded
2017-09-26 08:57:00,423 [salt.state       ][INFO    ][24662] Completed state [virt.set_autostart] at time 08:57:00.422921 duration_in_ms=19.805
2017-09-26 08:57:00,423 [salt.state       ][INFO    ][24662] Running state [virtng.init] at time 08:57:00.423124
2017-09-26 08:57:00,423 [salt.state       ][INFO    ][24662] Executing state module.run for virtng.init
2017-09-26 08:57:00,425 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:57:00,441 [salt.state       ][INFO    ][24662] unless execution succeeded
2017-09-26 08:57:00,441 [salt.state       ][INFO    ][24662] Completed state [virtng.init] at time 08:57:00.440919 duration_in_ms=17.793
2017-09-26 08:57:00,441 [salt.state       ][INFO    ][24662] Running state [virt.set_autostart] at time 08:57:00.441214
2017-09-26 08:57:00,442 [salt.state       ][INFO    ][24662] Executing state module.run for virt.set_autostart
2017-09-26 08:57:00,444 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:57:00,459 [salt.state       ][INFO    ][24662] unless execution succeeded
2017-09-26 08:57:00,459 [salt.state       ][INFO    ][24662] Completed state [virt.set_autostart] at time 08:57:00.459020 duration_in_ms=17.806
2017-09-26 08:57:00,459 [salt.state       ][INFO    ][24662] Running state [virtng.init] at time 08:57:00.459213
2017-09-26 08:57:00,459 [salt.state       ][INFO    ][24662] Executing state module.run for virtng.init
2017-09-26 08:57:00,461 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:57:00,477 [salt.state       ][INFO    ][24662] unless execution succeeded
2017-09-26 08:57:00,477 [salt.state       ][INFO    ][24662] Completed state [virtng.init] at time 08:57:00.476913 duration_in_ms=17.699
2017-09-26 08:57:00,477 [salt.state       ][INFO    ][24662] Running state [virt.set_autostart] at time 08:57:00.477140
2017-09-26 08:57:00,477 [salt.state       ][INFO    ][24662] Executing state module.run for virt.set_autostart
2017-09-26 08:57:00,479 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:57:00,494 [salt.state       ][INFO    ][24662] unless execution succeeded
2017-09-26 08:57:00,494 [salt.state       ][INFO    ][24662] Completed state [virt.set_autostart] at time 08:57:00.494412 duration_in_ms=17.272
2017-09-26 08:57:00,495 [salt.state       ][INFO    ][24662] Running state [virtng.init] at time 08:57:00.494604
2017-09-26 08:57:00,495 [salt.state       ][INFO    ][24662] Executing state module.run for virtng.init
2017-09-26 08:57:00,497 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:57:00,512 [salt.state       ][INFO    ][24662] unless execution succeeded
2017-09-26 08:57:00,512 [salt.state       ][INFO    ][24662] Completed state [virtng.init] at time 08:57:00.511837 duration_in_ms=17.232
2017-09-26 08:57:00,512 [salt.state       ][INFO    ][24662] Running state [virt.set_autostart] at time 08:57:00.512077
2017-09-26 08:57:00,512 [salt.state       ][INFO    ][24662] Executing state module.run for virt.set_autostart
2017-09-26 08:57:00,514 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:57:00,529 [salt.state       ][INFO    ][24662] unless execution succeeded
2017-09-26 08:57:00,529 [salt.state       ][INFO    ][24662] Completed state [virt.set_autostart] at time 08:57:00.529032 duration_in_ms=16.955
2017-09-26 08:57:00,529 [salt.state       ][INFO    ][24662] Running state [virtng.init] at time 08:57:00.529227
2017-09-26 08:57:00,529 [salt.state       ][INFO    ][24662] Executing state module.run for virtng.init
2017-09-26 08:57:00,531 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:57:00,545 [salt.state       ][INFO    ][24662] unless execution succeeded
2017-09-26 08:57:00,546 [salt.state       ][INFO    ][24662] Completed state [virtng.init] at time 08:57:00.545508 duration_in_ms=16.281
2017-09-26 08:57:00,546 [salt.state       ][INFO    ][24662] Running state [virt.set_autostart] at time 08:57:00.545723
2017-09-26 08:57:00,546 [salt.state       ][INFO    ][24662] Executing state module.run for virt.set_autostart
2017-09-26 08:57:00,548 [salt.loaded.int.module.cmdmod][INFO    ][24662] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-26 08:57:00,562 [salt.state       ][INFO    ][24662] unless execution succeeded
2017-09-26 08:57:00,563 [salt.state       ][INFO    ][24662] Completed state [virt.set_autostart] at time 08:57:00.562496 duration_in_ms=16.773
2017-09-26 08:57:00,565 [salt.minion      ][INFO    ][24662] Returning information for job: 20170926085656070234
2017-09-26 08:58:19,701 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170926085819686954
2017-09-26 08:58:19,716 [salt.minion      ][INFO    ][24777] Starting a new job with PID 24777
2017-09-26 08:58:22,679 [salt.state       ][INFO    ][24777] Loading fresh modules for state activity
2017-09-26 08:58:23,243 [salt.state       ][ERROR   ][24777] No contents found in top file
2017-09-26 08:58:23,244 [salt.utils.extmods][INFO    ][24777] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-26 08:58:23,247 [salt.utils.extmods][INFO    ][24777] Syncing beacons for environment 'base'
2017-09-26 08:58:23,247 [salt.utils.extmods][INFO    ][24777] Loading cache from salt://_beacons, for base)
2017-09-26 08:58:23,247 [salt.fileclient  ][INFO    ][24777] Caching directory '_beacons/' for environment 'base'
2017-09-26 08:58:23,281 [salt.utils.extmods][INFO    ][24777] Syncing modules for environment 'base'
2017-09-26 08:58:23,281 [salt.utils.extmods][INFO    ][24777] Loading cache from salt://_modules, for base)
2017-09-26 08:58:23,281 [salt.fileclient  ][INFO    ][24777] Caching directory '_modules/' for environment 'base'
2017-09-26 08:58:23,321 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-26 08:58:23,328 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-26 08:58:23,348 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-26 08:58:23,364 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-26 08:58:23,395 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-26 08:58:23,412 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-26 08:58:23,423 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-26 08:58:23,432 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-26 08:58:23,463 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-26 08:58:23,491 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-26 08:58:23,520 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-26 08:58:23,527 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-26 08:58:23,553 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-26 08:58:23,561 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-26 08:58:23,597 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-26 08:58:23,607 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-26 08:58:23,660 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-26 08:58:23,669 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-26 08:58:23,678 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-26 08:58:23,714 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-26 08:58:23,764 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-26 08:58:23,774 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-26 08:58:23,783 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-26 08:58:23,824 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-26 08:58:23,836 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-26 08:58:23,849 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-26 08:58:23,868 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-26 08:58:23,903 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-26 08:58:23,927 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-26 08:58:23,937 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-26 08:58:23,955 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-26 08:58:23,981 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-26 08:58:23,984 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-26 08:58:23,984 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-26 08:58:23,984 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-26 08:58:23,984 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-26 08:58:23,985 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-26 08:58:23,985 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-26 08:58:23,985 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-26 08:58:23,985 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-26 08:58:23,986 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-26 08:58:23,986 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-26 08:58:23,986 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-26 08:58:23,987 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-26 08:58:23,987 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-26 08:58:23,987 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-26 08:58:23,987 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-26 08:58:23,988 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-26 08:58:23,988 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-26 08:58:23,988 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-26 08:58:23,988 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-26 08:58:23,989 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-26 08:58:23,989 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-26 08:58:23,989 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-26 08:58:23,989 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-26 08:58:23,990 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-26 08:58:23,990 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-26 08:58:23,990 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-26 08:58:23,991 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-26 08:58:23,991 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-26 08:58:23,991 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-26 08:58:23,991 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-26 08:58:23,992 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-26 08:58:23,992 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-09-26 08:58:23,992 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-26 08:58:23,992 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-26 08:58:23,996 [salt.utils.extmods][INFO    ][24777] Syncing states for environment 'base'
2017-09-26 08:58:23,996 [salt.utils.extmods][INFO    ][24777] Loading cache from salt://_states, for base)
2017-09-26 08:58:23,996 [salt.fileclient  ][INFO    ][24777] Caching directory '_states/' for environment 'base'
2017-09-26 08:58:24,038 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-26 08:58:24,045 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-26 08:58:24,052 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-26 08:58:24,068 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-26 08:58:24,080 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-26 08:58:24,143 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-26 08:58:24,165 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-26 08:58:24,182 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-26 08:58:24,208 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-26 08:58:24,222 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-26 08:58:24,259 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-26 08:58:24,269 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-26 08:58:24,282 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-26 08:58:24,323 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-26 08:58:24,353 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-26 08:58:24,386 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-26 08:58:24,401 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-26 08:58:24,411 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-26 08:58:24,466 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-26 08:58:24,517 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-26 08:58:24,555 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-26 08:58:24,569 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-26 08:58:24,580 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-26 08:58:24,590 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-26 08:58:24,601 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-26 08:58:24,609 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-26 08:58:24,628 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-26 08:58:24,647 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-26 08:58:24,667 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-26 08:58:24,670 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-26 08:58:24,670 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-26 08:58:24,670 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-26 08:58:24,670 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-26 08:58:24,671 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-26 08:58:24,671 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-26 08:58:24,671 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-26 08:58:24,671 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-26 08:58:24,671 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-26 08:58:24,672 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-26 08:58:24,672 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-26 08:58:24,672 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-26 08:58:24,672 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-26 08:58:24,672 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-26 08:58:24,673 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-26 08:58:24,673 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-26 08:58:24,673 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-26 08:58:24,673 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-26 08:58:24,673 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-26 08:58:24,673 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-26 08:58:24,674 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-26 08:58:24,674 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-26 08:58:24,674 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-26 08:58:24,674 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-26 08:58:24,674 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-26 08:58:24,675 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-26 08:58:24,675 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-26 08:58:24,675 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-26 08:58:24,675 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-26 08:58:24,675 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-26 08:58:24,677 [salt.utils.extmods][INFO    ][24777] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-26 08:58:24,680 [salt.utils.extmods][INFO    ][24777] Syncing sdb for environment 'base'
2017-09-26 08:58:24,680 [salt.utils.extmods][INFO    ][24777] Loading cache from salt://_sdb, for base)
2017-09-26 08:58:24,680 [salt.fileclient  ][INFO    ][24777] Caching directory '_sdb/' for environment 'base'
2017-09-26 08:58:24,710 [salt.utils.extmods][INFO    ][24777] Syncing grains for environment 'base'
2017-09-26 08:58:24,710 [salt.utils.extmods][INFO    ][24777] Loading cache from salt://_grains, for base)
2017-09-26 08:58:24,710 [salt.fileclient  ][INFO    ][24777] Caching directory '_grains/' for environment 'base'
2017-09-26 08:58:24,817 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-26 08:58:24,827 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-26 08:58:24,834 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-26 08:58:24,905 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-26 08:58:24,917 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-26 08:58:24,965 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-26 08:58:24,980 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-26 08:58:24,992 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-26 08:58:25,005 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-26 08:58:25,014 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-26 08:58:25,025 [salt.fileclient  ][INFO    ][24777] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-26 08:58:25,028 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-26 08:58:25,028 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-26 08:58:25,029 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-26 08:58:25,029 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-26 08:58:25,029 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-26 08:58:25,029 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-26 08:58:25,029 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-26 08:58:25,030 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-26 08:58:25,030 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-26 08:58:25,030 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-26 08:58:25,030 [salt.utils.extmods][INFO    ][24777] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-26 08:58:25,031 [salt.utils.extmods][INFO    ][24777] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-26 08:58:25,033 [salt.utils.extmods][INFO    ][24777] Syncing renderers for environment 'base'
2017-09-26 08:58:25,033 [salt.utils.extmods][INFO    ][24777] Loading cache from salt://_renderers, for base)
2017-09-26 08:58:25,034 [salt.fileclient  ][INFO    ][24777] Caching directory '_renderers/' for environment 'base'
2017-09-26 08:58:25,052 [salt.utils.extmods][INFO    ][24777] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-26 08:58:25,054 [salt.utils.extmods][INFO    ][24777] Syncing returners for environment 'base'
2017-09-26 08:58:25,054 [salt.utils.extmods][INFO    ][24777] Loading cache from salt://_returners, for base)
2017-09-26 08:58:25,054 [salt.fileclient  ][INFO    ][24777] Caching directory '_returners/' for environment 'base'
2017-09-26 08:58:25,081 [salt.utils.extmods][INFO    ][24777] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-26 08:58:25,083 [salt.utils.extmods][INFO    ][24777] Syncing output for environment 'base'
2017-09-26 08:58:25,083 [salt.utils.extmods][INFO    ][24777] Loading cache from salt://_output, for base)
2017-09-26 08:58:25,083 [salt.fileclient  ][INFO    ][24777] Caching directory '_output/' for environment 'base'
2017-09-26 08:58:25,103 [salt.utils.extmods][INFO    ][24777] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-26 08:58:25,105 [salt.utils.extmods][INFO    ][24777] Syncing utils for environment 'base'
2017-09-26 08:58:25,105 [salt.utils.extmods][INFO    ][24777] Loading cache from salt://_utils, for base)
2017-09-26 08:58:25,105 [salt.fileclient  ][INFO    ][24777] Caching directory '_utils/' for environment 'base'
2017-09-26 08:58:25,129 [salt.utils.extmods][INFO    ][24777] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-26 08:58:25,133 [salt.utils.extmods][INFO    ][24777] Syncing log_handlers for environment 'base'
2017-09-26 08:58:25,133 [salt.utils.extmods][INFO    ][24777] Loading cache from salt://_log_handlers, for base)
2017-09-26 08:58:25,133 [salt.fileclient  ][INFO    ][24777] Caching directory '_log_handlers/' for environment 'base'
2017-09-26 08:58:25,174 [salt.utils.extmods][INFO    ][24777] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-26 08:58:25,176 [salt.utils.extmods][INFO    ][24777] Syncing proxy for environment 'base'
2017-09-26 08:58:25,177 [salt.utils.extmods][INFO    ][24777] Loading cache from salt://_proxy, for base)
2017-09-26 08:58:25,177 [salt.fileclient  ][INFO    ][24777] Caching directory '_proxy/' for environment 'base'
2017-09-26 08:58:25,205 [salt.utils.extmods][INFO    ][24777] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-26 08:58:25,208 [salt.utils.extmods][INFO    ][24777] Syncing engines for environment 'base'
2017-09-26 08:58:25,208 [salt.utils.extmods][INFO    ][24777] Loading cache from salt://_engines, for base)
2017-09-26 08:58:25,208 [salt.fileclient  ][INFO    ][24777] Caching directory '_engines/' for environment 'base'
2017-09-26 08:58:25,234 [salt.minion      ][INFO    ][24777] Returning information for job: 20170926085819686954
2017-09-26 09:32:28,196 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command test.ping with jid 20170926093228181275
2017-09-26 09:32:28,214 [salt.minion      ][INFO    ][25443] Starting a new job with PID 25443
2017-09-26 09:32:28,240 [salt.minion      ][INFO    ][25443] Returning information for job: 20170926093228181275
2017-09-26 09:35:22,403 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command state.sls with jid 20170926093522386382
2017-09-26 09:35:22,417 [salt.minion      ][INFO    ][25507] Starting a new job with PID 25507
2017-09-26 09:35:23,404 [salt.state       ][INFO    ][25507] Loading fresh modules for state activity
2017-09-26 09:35:23,429 [salt.fileclient  ][INFO    ][25507] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-26 09:35:23,447 [salt.fileclient  ][INFO    ][25507] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-26 09:35:23,471 [salt.fileclient  ][INFO    ][25507] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-26 09:35:23,770 [salt.state       ][INFO    ][25507] Running state [lsof] at time 09:35:23.769870
2017-09-26 09:35:23,770 [salt.state       ][INFO    ][25507] Executing state pkg.installed for lsof
2017-09-26 09:35:23,770 [salt.loaded.int.module.cmdmod][INFO    ][25507] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-26 09:35:24,046 [salt.state       ][INFO    ][25507] Package lsof is already installed
2017-09-26 09:35:24,047 [salt.state       ][INFO    ][25507] Completed state [lsof] at time 09:35:24.046625 duration_in_ms=276.754
2017-09-26 09:35:24,047 [salt.state       ][INFO    ][25507] Running state [keepalived] at time 09:35:24.046821
2017-09-26 09:35:24,047 [salt.state       ][INFO    ][25507] Executing state pkg.installed for keepalived
2017-09-26 09:35:24,063 [salt.loaded.int.module.cmdmod][INFO    ][25507] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-26 09:35:27,315 [salt.loaded.int.module.cmdmod][INFO    ][25507] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-09-26 09:35:32,452 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command saltutil.find_job with jid 20170926093532430881
2017-09-26 09:35:32,466 [salt.minion      ][INFO    ][26815] Starting a new job with PID 26815
2017-09-26 09:35:32,479 [salt.minion      ][INFO    ][26815] Returning information for job: 20170926093532430881
2017-09-26 09:35:35,012 [salt.loaded.int.module.cmdmod][INFO    ][25507] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-26 09:35:35,037 [salt.state       ][INFO    ][25507] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-09-26 09:35:35,046 [salt.state       ][INFO    ][25507] Loading fresh modules for state activity
2017-09-26 09:35:35,058 [salt.state       ][INFO    ][25507] Completed state [keepalived] at time 09:35:35.057909 duration_in_ms=11011.087
2017-09-26 09:35:35,060 [salt.state       ][INFO    ][25507] Running state [/etc/keepalived/keepalived.conf] at time 09:35:35.060117
2017-09-26 09:35:35,060 [salt.state       ][INFO    ][25507] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-26 09:35:35,087 [salt.fileclient  ][INFO    ][25507] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-26 09:35:35,116 [salt.fileclient  ][INFO    ][25507] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-26 09:35:35,123 [salt.state       ][INFO    ][25507] File changed:
New file
2017-09-26 09:35:35,123 [salt.state       ][INFO    ][25507] Completed state [/etc/keepalived/keepalived.conf] at time 09:35:35.123211 duration_in_ms=63.092
2017-09-26 09:35:35,181 [salt.state       ][INFO    ][25507] Running state [keepalived] at time 09:35:35.181054
2017-09-26 09:35:35,181 [salt.state       ][INFO    ][25507] Executing state service.running for keepalived
2017-09-26 09:35:35,183 [salt.loaded.int.module.cmdmod][INFO    ][25507] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-26 09:35:35,192 [salt.loaded.int.module.cmdmod][INFO    ][25507] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-26 09:35:35,198 [salt.loaded.int.module.cmdmod][INFO    ][25507] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-26 09:35:35,205 [salt.loaded.int.module.cmdmod][INFO    ][25507] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-26 09:35:35,212 [salt.loaded.int.module.cmdmod][INFO    ][25507] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-26 09:35:35,271 [salt.loaded.int.module.cmdmod][INFO    ][25507] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-26 09:35:35,279 [salt.loaded.int.module.cmdmod][INFO    ][25507] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-26 09:35:35,286 [salt.loaded.int.module.cmdmod][INFO    ][25507] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-26 09:35:35,293 [salt.state       ][INFO    ][25507] {'keepalived': True}
2017-09-26 09:35:35,293 [salt.state       ][INFO    ][25507] Completed state [keepalived] at time 09:35:35.292717 duration_in_ms=111.662
2017-09-26 09:35:35,293 [salt.minion      ][INFO    ][25507] Returning information for job: 20170926093522386382
2017-09-26 09:37:03,821 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command pillar.get with jid 20170926093703809477
2017-09-26 09:37:03,837 [salt.minion      ][INFO    ][27118] Starting a new job with PID 27118
2017-09-26 09:37:03,841 [salt.minion      ][INFO    ][27118] Returning information for job: 20170926093703809477
2017-09-26 09:43:07,809 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command state.sls with jid 20170926094307794276
2017-09-26 09:43:07,825 [salt.minion      ][INFO    ][27236] Starting a new job with PID 27236
2017-09-26 09:43:09,319 [salt.state       ][INFO    ][27236] Loading fresh modules for state activity
2017-09-26 09:43:09,341 [salt.fileclient  ][INFO    ][27236] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-26 09:43:09,362 [salt.fileclient  ][INFO    ][27236] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-26 09:43:09,622 [salt.state       ][INFO    ][27236] Running state [attr] at time 09:43:09.622279
2017-09-26 09:43:09,623 [salt.state       ][INFO    ][27236] Executing state pkg.installed for attr
2017-09-26 09:43:09,623 [salt.loaded.int.module.cmdmod][INFO    ][27236] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-26 09:43:09,900 [salt.loaded.int.module.cmdmod][INFO    ][27236] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-26 09:43:11,780 [salt.loaded.int.module.cmdmod][INFO    ][27236] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-09-26 09:43:14,030 [salt.loaded.int.module.cmdmod][INFO    ][27236] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-26 09:43:14,053 [salt.state       ][INFO    ][27236] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-26 09:43:14,061 [salt.state       ][INFO    ][27236] Loading fresh modules for state activity
2017-09-26 09:43:14,072 [salt.state       ][INFO    ][27236] Completed state [attr] at time 09:43:14.072454 duration_in_ms=4450.175
2017-09-26 09:43:14,077 [salt.state       ][INFO    ][27236] Running state [glusterfs-server] at time 09:43:14.077011
2017-09-26 09:43:14,077 [salt.state       ][INFO    ][27236] Executing state pkg.installed for glusterfs-server
2017-09-26 09:43:14,251 [salt.loaded.int.module.cmdmod][INFO    ][27236] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-09-26 09:43:17,906 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command saltutil.find_job with jid 20170926094317889510
2017-09-26 09:43:17,921 [salt.minion      ][INFO    ][28279] Starting a new job with PID 28279
2017-09-26 09:43:17,940 [salt.minion      ][INFO    ][28279] Returning information for job: 20170926094317889510
2017-09-26 09:43:28,125 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command saltutil.find_job with jid 20170926094328108940
2017-09-26 09:43:28,137 [salt.minion      ][INFO    ][31106] Starting a new job with PID 31106
2017-09-26 09:43:28,150 [salt.minion      ][INFO    ][31106] Returning information for job: 20170926094328108940
2017-09-26 09:43:31,925 [salt.loaded.int.module.cmdmod][INFO    ][27236] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-26 09:43:31,950 [salt.state       ][INFO    ][27236] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-09-26 09:43:31,957 [salt.state       ][INFO    ][27236] Loading fresh modules for state activity
2017-09-26 09:43:31,969 [salt.state       ][INFO    ][27236] Completed state [glusterfs-server] at time 09:43:31.968799 duration_in_ms=17891.788
2017-09-26 09:43:31,973 [salt.state       ][INFO    ][27236] Running state [bc] at time 09:43:31.973220
2017-09-26 09:43:31,973 [salt.state       ][INFO    ][27236] Executing state pkg.installed for bc
2017-09-26 09:43:32,228 [salt.loaded.int.module.cmdmod][INFO    ][27236] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-09-26 09:43:35,027 [salt.loaded.int.module.cmdmod][INFO    ][27236] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-26 09:43:35,051 [salt.state       ][INFO    ][27236] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-26 09:43:35,058 [salt.state       ][INFO    ][27236] Loading fresh modules for state activity
2017-09-26 09:43:35,071 [salt.state       ][INFO    ][27236] Completed state [bc] at time 09:43:35.070852 duration_in_ms=3097.631
2017-09-26 09:43:35,132 [salt.state       ][INFO    ][27236] Running state [glusterfs-server] at time 09:43:35.131930
2017-09-26 09:43:35,132 [salt.state       ][INFO    ][27236] Executing state service.running for glusterfs-server
2017-09-26 09:43:35,133 [salt.loaded.int.module.cmdmod][INFO    ][27236] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-26 09:43:35,143 [salt.loaded.int.module.cmdmod][INFO    ][27236] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-26 09:43:35,151 [salt.loaded.int.module.cmdmod][INFO    ][27236] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-26 09:43:35,161 [salt.state       ][INFO    ][27236] The service glusterfs-server is already running
2017-09-26 09:43:35,161 [salt.state       ][INFO    ][27236] Completed state [glusterfs-server] at time 09:43:35.161132 duration_in_ms=29.202
2017-09-26 09:43:35,163 [salt.state       ][INFO    ][27236] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:43:35.163025
2017-09-26 09:43:35,163 [salt.state       ][INFO    ][27236] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-26 09:43:35,174 [salt.state       ][INFO    ][27236] File changed:
New file
2017-09-26 09:43:35,175 [salt.state       ][INFO    ][27236] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:43:35.174600 duration_in_ms=11.575
2017-09-26 09:43:35,175 [salt.state       ][INFO    ][27236] Running state [/srv/glusterfs/glance] at time 09:43:35.174799
2017-09-26 09:43:35,175 [salt.state       ][INFO    ][27236] Executing state file.directory for /srv/glusterfs/glance
2017-09-26 09:43:35,176 [salt.state       ][INFO    ][27236] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-26 09:43:35,176 [salt.state       ][INFO    ][27236] Completed state [/srv/glusterfs/glance] at time 09:43:35.175623 duration_in_ms=0.823
2017-09-26 09:43:35,176 [salt.state       ][INFO    ][27236] Running state [/srv/glusterfs/keystone-keys] at time 09:43:35.175766
2017-09-26 09:43:35,176 [salt.state       ][INFO    ][27236] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-26 09:43:35,176 [salt.state       ][INFO    ][27236] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-26 09:43:35,176 [salt.state       ][INFO    ][27236] Completed state [/srv/glusterfs/keystone-keys] at time 09:43:35.176382 duration_in_ms=0.616
2017-09-26 09:43:35,177 [salt.state       ][INFO    ][27236] Running state [/srv/glusterfs/nova_instances] at time 09:43:35.176523
2017-09-26 09:43:35,177 [salt.state       ][INFO    ][27236] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-26 09:43:35,177 [salt.state       ][INFO    ][27236] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-26 09:43:35,177 [salt.state       ][INFO    ][27236] Completed state [/srv/glusterfs/nova_instances] at time 09:43:35.177161 duration_in_ms=0.638
2017-09-26 09:43:35,177 [salt.state       ][INFO    ][27236] Running state [/srv/glusterfs/keystone-credential-keys] at time 09:43:35.177302
2017-09-26 09:43:35,177 [salt.state       ][INFO    ][27236] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-26 09:43:35,178 [salt.state       ][INFO    ][27236] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-26 09:43:35,178 [salt.state       ][INFO    ][27236] Completed state [/srv/glusterfs/keystone-credential-keys] at time 09:43:35.177952 duration_in_ms=0.651
2017-09-26 09:43:35,179 [salt.minion      ][INFO    ][27236] Returning information for job: 20170926094307794276
2017-09-26 09:43:45,176 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command test.ping with jid 20170926094345161609
2017-09-26 09:43:45,192 [salt.minion      ][INFO    ][31952] Starting a new job with PID 31952
2017-09-26 09:43:45,217 [salt.minion      ][INFO    ][31952] Returning information for job: 20170926094345161609
2017-09-26 09:43:45,385 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command state.sls with jid 20170926094345368925
2017-09-26 09:43:45,397 [salt.minion      ][INFO    ][31957] Starting a new job with PID 31957
2017-09-26 09:43:46,903 [salt.state       ][INFO    ][31957] Loading fresh modules for state activity
2017-09-26 09:43:46,925 [salt.fileclient  ][INFO    ][31957] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-26 09:43:46,960 [salt.fileclient  ][INFO    ][31957] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-26 09:43:47,020 [salt.fileclient  ][INFO    ][31957] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-26 09:43:47,039 [salt.fileclient  ][INFO    ][31957] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-26 09:43:47,293 [salt.state       ][INFO    ][31957] Running state [attr] at time 09:43:47.292602
2017-09-26 09:43:47,293 [salt.state       ][INFO    ][31957] Executing state pkg.installed for attr
2017-09-26 09:43:47,293 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-26 09:43:47,552 [salt.state       ][INFO    ][31957] Package attr is already installed
2017-09-26 09:43:47,552 [salt.state       ][INFO    ][31957] Completed state [attr] at time 09:43:47.552213 duration_in_ms=259.612
2017-09-26 09:43:47,552 [salt.state       ][INFO    ][31957] Running state [glusterfs-server] at time 09:43:47.552416
2017-09-26 09:43:47,553 [salt.state       ][INFO    ][31957] Executing state pkg.installed for glusterfs-server
2017-09-26 09:43:47,555 [salt.state       ][INFO    ][31957] Package glusterfs-server is already installed
2017-09-26 09:43:47,555 [salt.state       ][INFO    ][31957] Completed state [glusterfs-server] at time 09:43:47.555254 duration_in_ms=2.838
2017-09-26 09:43:47,555 [salt.state       ][INFO    ][31957] Running state [bc] at time 09:43:47.555390
2017-09-26 09:43:47,556 [salt.state       ][INFO    ][31957] Executing state pkg.installed for bc
2017-09-26 09:43:47,558 [salt.state       ][INFO    ][31957] Package bc is already installed
2017-09-26 09:43:47,558 [salt.state       ][INFO    ][31957] Completed state [bc] at time 09:43:47.558095 duration_in_ms=2.704
2017-09-26 09:43:47,559 [salt.state       ][INFO    ][31957] Running state [glusterfs-server] at time 09:43:47.558869
2017-09-26 09:43:47,559 [salt.state       ][INFO    ][31957] Executing state service.running for glusterfs-server
2017-09-26 09:43:47,559 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-26 09:43:47,570 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-26 09:43:47,610 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-26 09:43:47,626 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-26 09:43:47,634 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-26 09:43:47,643 [salt.state       ][INFO    ][31957] The service glusterfs-server is already running
2017-09-26 09:43:47,643 [salt.state       ][INFO    ][31957] Completed state [glusterfs-server] at time 09:43:47.643238 duration_in_ms=84.367
2017-09-26 09:43:47,645 [salt.state       ][INFO    ][31957] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:43:47.644805
2017-09-26 09:43:47,645 [salt.state       ][INFO    ][31957] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-26 09:43:47,656 [salt.state       ][INFO    ][31957] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-26 09:43:47,656 [salt.state       ][INFO    ][31957] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:43:47.655677 duration_in_ms=10.873
2017-09-26 09:43:47,656 [salt.state       ][INFO    ][31957] Running state [/srv/glusterfs/glance] at time 09:43:47.655865
2017-09-26 09:43:47,656 [salt.state       ][INFO    ][31957] Executing state file.directory for /srv/glusterfs/glance
2017-09-26 09:43:47,656 [salt.state       ][INFO    ][31957] Directory /srv/glusterfs/glance is in the correct state
2017-09-26 09:43:47,657 [salt.state       ][INFO    ][31957] Completed state [/srv/glusterfs/glance] at time 09:43:47.656592 duration_in_ms=0.727
2017-09-26 09:43:47,657 [salt.state       ][INFO    ][31957] Running state [/srv/glusterfs/keystone-keys] at time 09:43:47.656772
2017-09-26 09:43:47,657 [salt.state       ][INFO    ][31957] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-26 09:43:47,657 [salt.state       ][INFO    ][31957] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-26 09:43:47,657 [salt.state       ][INFO    ][31957] Completed state [/srv/glusterfs/keystone-keys] at time 09:43:47.657465 duration_in_ms=0.693
2017-09-26 09:43:47,658 [salt.state       ][INFO    ][31957] Running state [/srv/glusterfs/nova_instances] at time 09:43:47.657640
2017-09-26 09:43:47,658 [salt.state       ][INFO    ][31957] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-26 09:43:47,658 [salt.state       ][INFO    ][31957] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-26 09:43:47,658 [salt.state       ][INFO    ][31957] Completed state [/srv/glusterfs/nova_instances] at time 09:43:47.658351 duration_in_ms=0.711
2017-09-26 09:43:47,659 [salt.state       ][INFO    ][31957] Running state [/srv/glusterfs/keystone-credential-keys] at time 09:43:47.658526
2017-09-26 09:43:47,659 [salt.state       ][INFO    ][31957] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-26 09:43:47,659 [salt.state       ][INFO    ][31957] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-26 09:43:47,659 [salt.state       ][INFO    ][31957] Completed state [/srv/glusterfs/keystone-credential-keys] at time 09:43:47.659250 duration_in_ms=0.724
2017-09-26 09:43:47,711 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command ['git', '--version'] in directory '/root'
2017-09-26 09:43:47,799 [salt.state       ][INFO    ][31957] Running state [sleep 5] at time 09:43:47.798925
2017-09-26 09:43:47,799 [salt.state       ][INFO    ][31957] Executing state cmd.wait for sleep 5
2017-09-26 09:43:47,799 [salt.state       ][INFO    ][31957] No changes made for sleep 5
2017-09-26 09:43:47,800 [salt.state       ][INFO    ][31957] Completed state [sleep 5] at time 09:43:47.799546 duration_in_ms=0.621
2017-09-26 09:43:47,800 [salt.state       ][INFO    ][31957] Running state [10.167.4.141] at time 09:43:47.799904
2017-09-26 09:43:47,800 [salt.state       ][INFO    ][31957] Executing state glusterfs.peered for 10.167.4.141
2017-09-26 09:43:47,800 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:47,811 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:47,865 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:47,874 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:48,266 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:48,277 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:48,336 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:48,345 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:48,400 [salt.state       ][INFO    ][31957] {'new': {'10.167.4.141': []}, 'old': None}
2017-09-26 09:43:48,401 [salt.state       ][INFO    ][31957] Completed state [10.167.4.141] at time 09:43:48.400490 duration_in_ms=600.586
2017-09-26 09:43:48,403 [salt.state       ][INFO    ][31957] Running state [10.167.4.142] at time 09:43:48.402821
2017-09-26 09:43:48,403 [salt.state       ][INFO    ][31957] Executing state glusterfs.peered for 10.167.4.142
2017-09-26 09:43:48,404 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:48,414 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:48,466 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:48,477 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:48,574 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:48,584 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:48,638 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:48,646 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:48,695 [salt.state       ][INFO    ][31957] Peering with localhost is not needed
2017-09-26 09:43:48,695 [salt.state       ][INFO    ][31957] Completed state [10.167.4.142] at time 09:43:48.695065 duration_in_ms=292.244
2017-09-26 09:43:48,697 [salt.state       ][INFO    ][31957] Running state [10.167.4.143] at time 09:43:48.697338
2017-09-26 09:43:48,698 [salt.state       ][INFO    ][31957] Executing state glusterfs.peered for 10.167.4.143
2017-09-26 09:43:48,698 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:48,707 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:48,756 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:48,764 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:49,083 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:49,093 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:49,171 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:49,181 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:49,335 [salt.state       ][INFO    ][31957] {'new': {'10.167.4.141': [], '10.167.4.143': []}, 'old': {'10.167.4.141': []}}
2017-09-26 09:43:49,335 [salt.state       ][INFO    ][31957] Completed state [10.167.4.143] at time 09:43:49.335195 duration_in_ms=637.856
2017-09-26 09:43:49,336 [salt.state       ][INFO    ][31957] Running state [glance] at time 09:43:49.336071
2017-09-26 09:43:49,336 [salt.state       ][INFO    ][31957] Executing state glusterfs.created for glance
2017-09-26 09:43:49,337 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:49,346 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:49,399 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:49,408 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:50,452 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:50,464 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:51,659 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:51,671 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:51,724 [salt.state       ][INFO    ][31957] {'new': ['glance'], 'old': []}
2017-09-26 09:43:51,724 [salt.state       ][INFO    ][31957] Completed state [glance] at time 09:43:51.724366 duration_in_ms=2388.294
2017-09-26 09:43:51,727 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 09:43:51.727236
2017-09-26 09:43:51,728 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-26 09:43:51,728 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-26 09:43:51,782 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-09-26 09:43:52,467 [salt.state       ][INFO    ][31957] {'pid': 32182, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:43:52,467 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 09:43:52.466961 duration_in_ms=739.724
2017-09-26 09:43:52,468 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 09:43:52.467560
2017-09-26 09:43:52,468 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-26 09:43:52,468 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-26 09:43:52,524 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-09-26 09:43:53,223 [salt.state       ][INFO    ][31957] {'pid': 32201, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:43:53,224 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 09:43:53.223477 duration_in_ms=755.917
2017-09-26 09:43:53,224 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 09:43:53.224028
2017-09-26 09:43:53,224 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-26 09:43:53,225 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-26 09:43:53,284 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-09-26 09:43:55,427 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command saltutil.find_job with jid 20170926094355410769
2017-09-26 09:43:55,441 [salt.minion      ][INFO    ][32228] Starting a new job with PID 32228
2017-09-26 09:43:55,453 [salt.minion      ][INFO    ][32228] Returning information for job: 20170926094355410769
2017-09-26 09:43:55,942 [salt.state       ][INFO    ][31957] {'pid': 32218, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:43:55,943 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 09:43:55.942455 duration_in_ms=2718.426
2017-09-26 09:43:55,943 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 09:43:55.943025
2017-09-26 09:43:55,943 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-26 09:43:55,944 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-26 09:43:56,002 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-09-26 09:43:56,672 [salt.state       ][INFO    ][31957] {'pid': 32243, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:43:56,673 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 09:43:56.672560 duration_in_ms=729.534
2017-09-26 09:43:56,673 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 09:43:56.673109
2017-09-26 09:43:56,673 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-26 09:43:56,674 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-26 09:43:56,731 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-09-26 09:43:57,378 [salt.state       ][INFO    ][31957] {'pid': 32260, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:43:57,378 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 09:43:57.378281 duration_in_ms=705.17
2017-09-26 09:43:57,379 [salt.state       ][INFO    ][31957] Running state [glance] at time 09:43:57.379343
2017-09-26 09:43:57,380 [salt.state       ][INFO    ][31957] Executing state glusterfs.started for glance
2017-09-26 09:43:57,380 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:57,392 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:57,448 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:57,458 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:57,517 [salt.state       ][INFO    ][31957] Volume glance is already started
2017-09-26 09:43:57,518 [salt.state       ][INFO    ][31957] Completed state [glance] at time 09:43:57.517585 duration_in_ms=138.242
2017-09-26 09:43:57,518 [salt.state       ][INFO    ][31957] Running state [keystone-keys] at time 09:43:57.518431
2017-09-26 09:43:57,519 [salt.state       ][INFO    ][31957] Executing state glusterfs.created for keystone-keys
2017-09-26 09:43:57,519 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:57,528 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:57,580 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:57,589 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:43:58,388 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:43:58,399 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:01,294 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:01,306 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:01,359 [salt.state       ][INFO    ][31957] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-09-26 09:44:01,360 [salt.state       ][INFO    ][31957] Completed state [keystone-keys] at time 09:44:01.359699 duration_in_ms=3841.268
2017-09-26 09:44:01,363 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 09:44:01.362831
2017-09-26 09:44:01,363 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-26 09:44:01,364 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-26 09:44:01,415 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-09-26 09:44:02,121 [salt.state       ][INFO    ][31957] {'pid': 32371, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:02,121 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 09:44:02.121408 duration_in_ms=758.576
2017-09-26 09:44:02,122 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:44:02.121964
2017-09-26 09:44:02,122 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-26 09:44:02,126 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-26 09:44:02,182 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-09-26 09:44:02,868 [salt.state       ][INFO    ][31957] {'pid': 32389, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:02,869 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:44:02.868673 duration_in_ms=746.708
2017-09-26 09:44:02,870 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:44:02.869562
2017-09-26 09:44:02,870 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-26 09:44:02,871 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-26 09:44:02,928 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-09-26 09:44:03,619 [salt.state       ][INFO    ][31957] {'pid': 32407, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:03,620 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:44:03.619673 duration_in_ms=750.11
2017-09-26 09:44:03,620 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 09:44:03.620333
2017-09-26 09:44:03,621 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-26 09:44:03,621 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-26 09:44:03,680 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-09-26 09:44:05,569 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command saltutil.find_job with jid 20170926094405552751
2017-09-26 09:44:05,583 [salt.minion      ][INFO    ][32436] Starting a new job with PID 32436
2017-09-26 09:44:05,595 [salt.minion      ][INFO    ][32436] Returning information for job: 20170926094405552751
2017-09-26 09:44:06,361 [salt.state       ][INFO    ][31957] {'pid': 32424, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:06,361 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 09:44:06.361097 duration_in_ms=2740.763
2017-09-26 09:44:06,362 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 09:44:06.361688
2017-09-26 09:44:06,362 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-26 09:44:06,363 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-26 09:44:06,420 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-09-26 09:44:07,049 [salt.state       ][INFO    ][31957] {'pid': 32449, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:07,049 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 09:44:07.049090 duration_in_ms=687.401
2017-09-26 09:44:07,050 [salt.state       ][INFO    ][31957] Running state [keystone-keys] at time 09:44:07.050140
2017-09-26 09:44:07,050 [salt.state       ][INFO    ][31957] Executing state glusterfs.started for keystone-keys
2017-09-26 09:44:07,051 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:07,064 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:07,118 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:07,129 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:07,187 [salt.state       ][INFO    ][31957] Volume keystone-keys is already started
2017-09-26 09:44:07,188 [salt.state       ][INFO    ][31957] Completed state [keystone-keys] at time 09:44:07.187508 duration_in_ms=137.367
2017-09-26 09:44:07,189 [salt.state       ][INFO    ][31957] Running state [nova_instances] at time 09:44:07.188523
2017-09-26 09:44:07,189 [salt.state       ][INFO    ][31957] Executing state glusterfs.created for nova_instances
2017-09-26 09:44:07,189 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:07,199 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:07,253 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:07,263 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:07,998 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:08,010 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:10,922 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:10,934 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:10,993 [salt.state       ][INFO    ][31957] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-09-26 09:44:10,993 [salt.state       ][INFO    ][31957] Completed state [nova_instances] at time 09:44:10.993051 duration_in_ms=3804.527
2017-09-26 09:44:10,996 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 09:44:10.996335
2017-09-26 09:44:10,997 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-26 09:44:10,997 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-26 09:44:11,053 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-09-26 09:44:11,733 [salt.state       ][INFO    ][31957] {'pid': 32562, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:11,733 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 09:44:11.733093 duration_in_ms=736.757
2017-09-26 09:44:11,734 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 09:44:11.733671
2017-09-26 09:44:11,734 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-09-26 09:44:11,735 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-09-26 09:44:11,790 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'' in directory '/root'
2017-09-26 09:44:12,542 [salt.state       ][INFO    ][31957] {'pid': 32580, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:12,542 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 09:44:12.541917 duration_in_ms=808.245
2017-09-26 09:44:12,543 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 09:44:12.542488
2017-09-26 09:44:12,543 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-09-26 09:44:12,544 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-09-26 09:44:12,602 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'On'' in directory '/root'
2017-09-26 09:44:13,277 [salt.state       ][INFO    ][31957] {'pid': 32597, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:13,278 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 09:44:13.277480 duration_in_ms=734.99
2017-09-26 09:44:13,278 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 09:44:13.278040
2017-09-26 09:44:13,278 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-09-26 09:44:13,279 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-09-26 09:44:13,336 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'On'' in directory '/root'
2017-09-26 09:44:15,710 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command saltutil.find_job with jid 20170926094415694555
2017-09-26 09:44:15,724 [salt.minion      ][INFO    ][32628] Starting a new job with PID 32628
2017-09-26 09:44:15,735 [salt.minion      ][INFO    ][32628] Returning information for job: 20170926094415694555
2017-09-26 09:44:16,044 [salt.state       ][INFO    ][31957] {'pid': 32614, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:16,044 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 09:44:16.044072 duration_in_ms=2766.03
2017-09-26 09:44:16,045 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 09:44:16.044651
2017-09-26 09:44:16,045 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-26 09:44:16,046 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-26 09:44:16,103 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-09-26 09:44:16,761 [salt.state       ][INFO    ][31957] {'pid': 32640, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:16,762 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 09:44:16.761558 duration_in_ms=716.906
2017-09-26 09:44:16,763 [salt.state       ][INFO    ][31957] Running state [nova_instances] at time 09:44:16.762608
2017-09-26 09:44:16,763 [salt.state       ][INFO    ][31957] Executing state glusterfs.started for nova_instances
2017-09-26 09:44:16,763 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:16,776 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:16,830 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:16,839 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:16,895 [salt.state       ][INFO    ][31957] Volume nova_instances is already started
2017-09-26 09:44:16,895 [salt.state       ][INFO    ][31957] Completed state [nova_instances] at time 09:44:16.895374 duration_in_ms=132.766
2017-09-26 09:44:16,896 [salt.state       ][INFO    ][31957] Running state [keystone-credential-keys] at time 09:44:16.896271
2017-09-26 09:44:16,897 [salt.state       ][INFO    ][31957] Executing state glusterfs.created for keystone-credential-keys
2017-09-26 09:44:16,897 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:16,907 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:16,960 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:16,969 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:17,706 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:17,717 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:20,651 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:20,664 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:20,721 [salt.state       ][INFO    ][31957] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-09-26 09:44:20,721 [salt.state       ][INFO    ][31957] Completed state [keystone-credential-keys] at time 09:44:20.720817 duration_in_ms=3824.545
2017-09-26 09:44:20,724 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 09:44:20.724097
2017-09-26 09:44:20,724 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-26 09:44:20,725 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-26 09:44:20,779 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-09-26 09:44:21,503 [salt.state       ][INFO    ][31957] {'pid': 32758, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:21,503 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 09:44:21.503061 duration_in_ms=778.964
2017-09-26 09:44:21,504 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:44:21.503622
2017-09-26 09:44:21,504 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-26 09:44:21,504 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-26 09:44:21,560 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-09-26 09:44:22,240 [salt.state       ][INFO    ][31957] {'pid': 307, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:22,240 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:44:22.240165 duration_in_ms=736.542
2017-09-26 09:44:22,241 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 09:44:22.240769
2017-09-26 09:44:22,241 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-26 09:44:22,242 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-26 09:44:22,302 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-09-26 09:44:25,028 [salt.state       ][INFO    ][31957] {'pid': 325, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:25,028 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 09:44:25.028222 duration_in_ms=2787.451
2017-09-26 09:44:25,029 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:44:25.028924
2017-09-26 09:44:25,029 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-26 09:44:25,030 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-26 09:44:25,086 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-09-26 09:44:25,827 [salt.state       ][INFO    ][31957] {'pid': 346, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:25,827 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:44:25.827122 duration_in_ms=798.198
2017-09-26 09:44:25,828 [salt.state       ][INFO    ][31957] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 09:44:25.827676
2017-09-26 09:44:25,828 [salt.state       ][INFO    ][31957] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-26 09:44:25,829 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-26 09:44:25,852 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command saltutil.find_job with jid 20170926094425835272
2017-09-26 09:44:25,867 [salt.minion      ][INFO    ][361] Starting a new job with PID 361
2017-09-26 09:44:25,878 [salt.minion      ][INFO    ][361] Returning information for job: 20170926094425835272
2017-09-26 09:44:25,888 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-09-26 09:44:26,522 [salt.state       ][INFO    ][31957] {'pid': 368, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-26 09:44:26,523 [salt.state       ][INFO    ][31957] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 09:44:26.522471 duration_in_ms=694.794
2017-09-26 09:44:26,524 [salt.state       ][INFO    ][31957] Running state [keystone-credential-keys] at time 09:44:26.523507
2017-09-26 09:44:26,524 [salt.state       ][INFO    ][31957] Executing state glusterfs.started for keystone-credential-keys
2017-09-26 09:44:26,524 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:26,534 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:26,588 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --version' in directory '/root'
2017-09-26 09:44:26,597 [salt.loaded.int.module.cmdmod][INFO    ][31957] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-26 09:44:26,654 [salt.state       ][INFO    ][31957] Volume keystone-credential-keys is already started
2017-09-26 09:44:26,654 [salt.state       ][INFO    ][31957] Completed state [keystone-credential-keys] at time 09:44:26.654141 duration_in_ms=130.634
2017-09-26 09:44:26,656 [salt.minion      ][INFO    ][31957] Returning information for job: 20170926094345368925
2017-09-26 09:44:43,190 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command test.ping with jid 20170926094443173630
2017-09-26 09:44:43,205 [salt.minion      ][INFO    ][401] Starting a new job with PID 401
2017-09-26 09:44:43,234 [salt.minion      ][INFO    ][401] Returning information for job: 20170926094443173630
2017-09-26 09:44:43,397 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command cmd.run with jid 20170926094443381336
2017-09-26 09:44:43,410 [salt.minion      ][INFO    ][406] Starting a new job with PID 406
2017-09-26 09:44:43,415 [salt.loaded.int.module.cmdmod][INFO    ][406] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-26 09:44:43,531 [salt.minion      ][INFO    ][406] Returning information for job: 20170926094443381336
2017-09-26 09:52:46,322 [salt.utils.schedule][INFO    ][24286] Running scheduled job: __mine_interval
2017-09-26 10:52:46,322 [salt.utils.schedule][INFO    ][24286] Running scheduled job: __mine_interval
2017-09-26 11:02:36,201 [salt.minion      ][INFO    ][24286] User sudo_ubuntu Executing command cp.push_dir with jid 20170926110236189685
2017-09-26 11:02:36,220 [salt.minion      ][INFO    ][1642] Starting a new job with PID 1642
