2017-09-25 02:39:28,857 [salt.cli.daemons ][WARNING ][2456] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-25 02:57:57,129 [salt.state       ][ERROR   ][3814] No contents found in top file
2017-09-25 02:58:14,951 [salt.utils.parsers][WARNING ][2456] Minion received a SIGTERM. Exiting.
2017-09-25 03:00:28,046 [salt.cli.daemons ][WARNING ][3239] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-25 03:03:29,050 [salt.loaded.int.module.cmdmod][ERROR   ][11457] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-09-25 03:03:29,050 [salt.loaded.int.module.cmdmod][ERROR   ][11457] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-09-25 03:03:29,050 [salt.loaded.int.module.cmdmod][ERROR   ][11457] retcode: 1
2017-09-25 03:03:29,050 [salt.state       ][ERROR   ][11457] {'pid': 16259, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-09-25 03:03:46,901 [py.warnings      ][WARNING ][16300] /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-25 03:04:49,525 [salt.loaded.int.module.cmdmod][ERROR   ][16300] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 03:04:49,526 [salt.loaded.int.module.cmdmod][ERROR   ][16300] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 03:04:56,196 [salt.loaded.int.module.cmdmod][ERROR   ][16300] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 03:04:56,196 [salt.loaded.int.module.cmdmod][ERROR   ][16300] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 03:05:04,075 [salt.loaded.int.module.cmdmod][ERROR   ][16300] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 03:05:04,076 [salt.loaded.int.module.cmdmod][ERROR   ][16300] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 03:05:17,841 [salt.loaded.int.module.cmdmod][ERROR   ][16300] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 03:05:17,842 [salt.loaded.int.module.cmdmod][ERROR   ][16300] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 03:05:26,074 [salt.loaded.int.module.cmdmod][ERROR   ][16300] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 03:05:26,075 [salt.loaded.int.module.cmdmod][ERROR   ][16300] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 03:05:32,295 [salt.loaded.int.module.cmdmod][ERROR   ][16300] 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-25 03:05:34,381 [salt.loaded.int.module.cmdmod][INFO    ][23916] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-25 03:05:34,387 [salt.loaded.int.module.cmdmod][INFO    ][23916] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-25 03:05:34,394 [salt.loaded.int.module.cmdmod][INFO    ][23916] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-25 03:05:34,401 [salt.utils.parsers][WARNING ][3239] Minion received a SIGTERM. Exiting.
2017-09-25 03:05:34,680 [salt.cli.daemons ][INFO    ][23991] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-odl-ha.local"
2017-09-25 03:05:35,186 [salt.minion      ][INFO    ][23991] Creating minion process manager
2017-09-25 03:05:35,186 [salt.cli.daemons ][WARNING ][23991] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-25 03:05:35,186 [salt.cli.daemons ][INFO    ][23991] The Salt Minion is starting up
2017-09-25 03:05:35,186 [salt.minion      ][INFO    ][23991] Minion is starting as user 'root'
2017-09-25 03:05:35,187 [salt.utils.event ][INFO    ][23991] Starting pull socket on /var/run/salt/minion/minion_event_2d6d7b82d1_pull.ipc
2017-09-25 03:05:36,056 [salt.loaded.int.module.cmdmod][INFO    ][23991] Executing command ['date', '+%z'] in directory '/root'
2017-09-25 03:05:36,066 [salt.utils.schedule][INFO    ][23991] Updating job settings for scheduled job: __mine_interval
2017-09-25 03:05:36,068 [salt.minion      ][INFO    ][23991] Added mine.update to scheduler
2017-09-25 03:05:36,321 [salt.minion      ][INFO    ][23991] Minion is ready to receive requests!
2017-09-25 03:05:37,322 [salt.utils.schedule][INFO    ][23991] Running scheduled job: __mine_interval
2017-09-25 03:05:44,766 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170925030544754523
2017-09-25 03:05:44,782 [salt.minion      ][INFO    ][24092] Starting a new job with PID 24092
2017-09-25 03:05:46,413 [salt.state       ][INFO    ][24092] Loading fresh modules for state activity
2017-09-25 03:05:46,436 [salt.state       ][ERROR   ][24092] No contents found in top file
2017-09-25 03:05:46,437 [salt.utils.extmods][INFO    ][24092] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-25 03:05:46,440 [salt.utils.extmods][INFO    ][24092] Syncing beacons for environment 'base'
2017-09-25 03:05:46,440 [salt.utils.extmods][INFO    ][24092] Loading cache from salt://_beacons, for base)
2017-09-25 03:05:46,441 [salt.fileclient  ][INFO    ][24092] Caching directory '_beacons/' for environment 'base'
2017-09-25 03:05:46,472 [salt.utils.extmods][INFO    ][24092] Syncing modules for environment 'base'
2017-09-25 03:05:46,472 [salt.utils.extmods][INFO    ][24092] Loading cache from salt://_modules, for base)
2017-09-25 03:05:46,472 [salt.fileclient  ][INFO    ][24092] Caching directory '_modules/' for environment 'base'
2017-09-25 03:05:46,586 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-25 03:05:46,651 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-25 03:05:46,718 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-25 03:05:46,729 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-25 03:05:46,759 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-25 03:05:46,784 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-25 03:05:46,909 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-25 03:05:47,020 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-25 03:05:47,095 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-25 03:05:47,208 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-25 03:05:47,330 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-25 03:05:47,406 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-25 03:05:47,517 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-25 03:05:47,616 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-25 03:05:47,718 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-25 03:05:47,748 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-25 03:05:47,790 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-25 03:05:47,802 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-25 03:05:47,856 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-25 03:05:47,867 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-25 03:05:47,916 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-25 03:05:47,946 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-25 03:05:48,069 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-25 03:05:48,133 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-25 03:05:48,210 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-25 03:05:48,303 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-25 03:05:48,366 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-25 03:05:48,389 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-25 03:05:48,433 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-25 03:05:48,444 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-25 03:05:48,454 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-25 03:05:48,473 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-25 03:05:48,476 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-25 03:05:48,476 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-25 03:05:48,505 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-25 03:05:48,505 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-25 03:05:48,529 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-25 03:05:48,545 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-25 03:05:48,546 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-25 03:05:48,553 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-25 03:05:48,554 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-25 03:05:48,555 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-25 03:05:48,555 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-25 03:05:48,556 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-25 03:05:48,562 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-25 03:05:48,566 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-25 03:05:48,572 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-25 03:05:48,573 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-25 03:05:48,573 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-25 03:05:48,574 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-25 03:05:48,575 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-25 03:05:48,575 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-25 03:05:48,576 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-25 03:05:48,581 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-25 03:05:48,582 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-25 03:05:48,583 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-25 03:05:48,583 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-25 03:05:48,584 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-25 03:05:48,584 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-25 03:05:48,585 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-25 03:05:48,585 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-25 03:05:48,586 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-25 03:05:48,586 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-25 03:05:48,587 [salt.utils.extmods][INFO    ][24092] 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-25 03:05:48,587 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-25 03:05:48,587 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-25 03:05:48,593 [salt.utils.extmods][INFO    ][24092] Syncing states for environment 'base'
2017-09-25 03:05:48,593 [salt.utils.extmods][INFO    ][24092] Loading cache from salt://_states, for base)
2017-09-25 03:05:48,593 [salt.fileclient  ][INFO    ][24092] Caching directory '_states/' for environment 'base'
2017-09-25 03:05:48,649 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-25 03:05:48,685 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-25 03:05:48,700 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-25 03:05:48,724 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-25 03:05:48,757 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-25 03:05:48,793 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-25 03:05:48,804 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-25 03:05:48,836 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-25 03:05:48,860 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-25 03:05:48,907 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-25 03:05:48,944 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-25 03:05:48,955 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-25 03:05:48,986 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-25 03:05:49,021 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-25 03:05:49,052 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-25 03:05:49,093 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-25 03:05:49,119 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-25 03:05:49,137 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-25 03:05:49,159 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-25 03:05:49,190 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-25 03:05:49,238 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-25 03:05:49,276 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-25 03:05:49,394 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-25 03:05:49,454 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-25 03:05:49,489 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-25 03:05:49,556 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-25 03:05:49,586 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-25 03:05:49,678 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-25 03:05:49,712 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-25 03:05:49,715 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-25 03:05:49,715 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-25 03:05:49,715 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-25 03:05:49,715 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-25 03:05:49,715 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-25 03:05:49,716 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-25 03:05:49,716 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-25 03:05:49,716 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-25 03:05:49,716 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-25 03:05:49,716 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-25 03:05:49,717 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-25 03:05:49,717 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-25 03:05:49,717 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-25 03:05:49,717 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-25 03:05:49,717 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-25 03:05:49,718 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-25 03:05:49,718 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-25 03:05:49,718 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-25 03:05:49,718 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-25 03:05:49,718 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-25 03:05:49,719 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-25 03:05:49,719 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-25 03:05:49,719 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-25 03:05:49,719 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-25 03:05:49,719 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-25 03:05:49,720 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-25 03:05:49,720 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-25 03:05:49,720 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-25 03:05:49,720 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-25 03:05:49,720 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-25 03:05:49,722 [salt.utils.extmods][INFO    ][24092] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-25 03:05:49,725 [salt.utils.extmods][INFO    ][24092] Syncing sdb for environment 'base'
2017-09-25 03:05:49,725 [salt.utils.extmods][INFO    ][24092] Loading cache from salt://_sdb, for base)
2017-09-25 03:05:49,725 [salt.fileclient  ][INFO    ][24092] Caching directory '_sdb/' for environment 'base'
2017-09-25 03:05:49,752 [salt.utils.extmods][INFO    ][24092] Syncing grains for environment 'base'
2017-09-25 03:05:49,752 [salt.utils.extmods][INFO    ][24092] Loading cache from salt://_grains, for base)
2017-09-25 03:05:49,753 [salt.fileclient  ][INFO    ][24092] Caching directory '_grains/' for environment 'base'
2017-09-25 03:05:49,813 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-25 03:05:49,937 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-25 03:05:49,994 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-25 03:05:50,012 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-25 03:05:50,055 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-25 03:05:50,079 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-25 03:05:50,104 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-25 03:05:50,115 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-25 03:05:50,132 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-25 03:05:50,159 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-25 03:05:50,217 [salt.fileclient  ][INFO    ][24092] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-25 03:05:50,220 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-25 03:05:50,252 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-25 03:05:50,276 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-25 03:05:50,281 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-25 03:05:50,322 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-25 03:05:50,354 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-25 03:05:50,360 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-25 03:05:50,384 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-25 03:05:50,394 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-25 03:05:50,401 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-25 03:05:50,442 [salt.utils.extmods][INFO    ][24092] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-25 03:05:50,487 [salt.utils.extmods][INFO    ][24092] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-25 03:05:50,490 [salt.utils.extmods][INFO    ][24092] Syncing renderers for environment 'base'
2017-09-25 03:05:50,490 [salt.utils.extmods][INFO    ][24092] Loading cache from salt://_renderers, for base)
2017-09-25 03:05:50,490 [salt.fileclient  ][INFO    ][24092] Caching directory '_renderers/' for environment 'base'
2017-09-25 03:05:50,520 [salt.utils.extmods][INFO    ][24092] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-25 03:05:50,522 [salt.utils.extmods][INFO    ][24092] Syncing returners for environment 'base'
2017-09-25 03:05:50,522 [salt.utils.extmods][INFO    ][24092] Loading cache from salt://_returners, for base)
2017-09-25 03:05:50,522 [salt.fileclient  ][INFO    ][24092] Caching directory '_returners/' for environment 'base'
2017-09-25 03:05:50,552 [salt.utils.extmods][INFO    ][24092] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-25 03:05:50,554 [salt.utils.extmods][INFO    ][24092] Syncing output for environment 'base'
2017-09-25 03:05:50,554 [salt.utils.extmods][INFO    ][24092] Loading cache from salt://_output, for base)
2017-09-25 03:05:50,555 [salt.fileclient  ][INFO    ][24092] Caching directory '_output/' for environment 'base'
2017-09-25 03:05:50,593 [salt.utils.extmods][INFO    ][24092] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-25 03:05:50,596 [salt.utils.extmods][INFO    ][24092] Syncing utils for environment 'base'
2017-09-25 03:05:50,596 [salt.utils.extmods][INFO    ][24092] Loading cache from salt://_utils, for base)
2017-09-25 03:05:50,596 [salt.fileclient  ][INFO    ][24092] Caching directory '_utils/' for environment 'base'
2017-09-25 03:05:50,626 [salt.utils.extmods][INFO    ][24092] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-25 03:05:50,629 [salt.utils.extmods][INFO    ][24092] Syncing log_handlers for environment 'base'
2017-09-25 03:05:50,629 [salt.utils.extmods][INFO    ][24092] Loading cache from salt://_log_handlers, for base)
2017-09-25 03:05:50,629 [salt.fileclient  ][INFO    ][24092] Caching directory '_log_handlers/' for environment 'base'
2017-09-25 03:05:50,660 [salt.utils.extmods][INFO    ][24092] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-25 03:05:50,663 [salt.utils.extmods][INFO    ][24092] Syncing proxy for environment 'base'
2017-09-25 03:05:50,663 [salt.utils.extmods][INFO    ][24092] Loading cache from salt://_proxy, for base)
2017-09-25 03:05:50,663 [salt.fileclient  ][INFO    ][24092] Caching directory '_proxy/' for environment 'base'
2017-09-25 03:05:50,693 [salt.utils.extmods][INFO    ][24092] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-25 03:05:50,696 [salt.utils.extmods][INFO    ][24092] Syncing engines for environment 'base'
2017-09-25 03:05:50,696 [salt.utils.extmods][INFO    ][24092] Loading cache from salt://_engines, for base)
2017-09-25 03:05:50,696 [salt.fileclient  ][INFO    ][24092] Caching directory '_engines/' for environment 'base'
2017-09-25 03:05:50,730 [salt.minion      ][INFO    ][24092] Returning information for job: 20170925030544754523
2017-09-25 03:05:51,916 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command state.sls with jid 20170925030551759844
2017-09-25 03:05:51,928 [salt.minion      ][INFO    ][24190] Starting a new job with PID 24190
2017-09-25 03:05:52,335 [salt.state       ][INFO    ][24190] Loading fresh modules for state activity
2017-09-25 03:05:52,361 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-25 03:05:52,416 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-25 03:05:52,491 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:05:52,556 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-25 03:05:52,571 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-25 03:05:52,607 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:05:52,659 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-25 03:05:52,681 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 03:05:52,734 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-25 03:05:52,751 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-25 03:05:52,772 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 03:05:52,787 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-25 03:05:52,794 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-25 03:05:52,827 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-25 03:05:52,840 [py.warnings      ][WARNING ][24190] /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-25 03:05:52,841 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'salt-minion --version' in directory '/root'
2017-09-25 03:05:53,101 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-25 03:05:53,123 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-25 03:05:53,160 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-25 03:05:53,172 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-25 03:05:53,223 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-25 03:05:53,268 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-25 03:05:53,322 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-25 03:05:53,341 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:05:53,418 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-25 03:05:53,434 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 03:05:53,475 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-25 03:05:53,550 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-25 03:05:53,561 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 03:05:53,574 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-25 03:05:53,581 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-25 03:05:53,603 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-25 03:05:53,616 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'salt-minion --version' in directory '/root'
2017-09-25 03:05:53,856 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-25 03:05:53,877 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-25 03:05:53,889 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-25 03:05:53,901 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-25 03:05:53,999 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-25 03:05:54,102 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-25 03:05:54,192 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-25 03:05:54,264 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:05:54,671 [salt.state       ][INFO    ][24190] Running state [salt-minion] at time 03:05:54.670855
2017-09-25 03:05:54,671 [salt.state       ][INFO    ][24190] Executing state pkg.installed for salt-minion
2017-09-25 03:05:54,672 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:05:54,950 [salt.state       ][INFO    ][24190] Package salt-minion is already installed
2017-09-25 03:05:54,950 [salt.state       ][INFO    ][24190] Completed state [salt-minion] at time 03:05:54.950339 duration_in_ms=279.484
2017-09-25 03:05:54,951 [salt.state       ][INFO    ][24190] Running state [python-yaml] at time 03:05:54.950571
2017-09-25 03:05:54,951 [salt.state       ][INFO    ][24190] Executing state pkg.installed for python-yaml
2017-09-25 03:05:54,953 [salt.state       ][INFO    ][24190] Package python-yaml is already installed
2017-09-25 03:05:54,953 [salt.state       ][INFO    ][24190] Completed state [python-yaml] at time 03:05:54.953438 duration_in_ms=2.867
2017-09-25 03:05:54,954 [salt.state       ][INFO    ][24190] Running state [python-psutil] at time 03:05:54.953582
2017-09-25 03:05:54,954 [salt.state       ][INFO    ][24190] Executing state pkg.installed for python-psutil
2017-09-25 03:05:54,956 [salt.state       ][INFO    ][24190] Package python-psutil is already installed
2017-09-25 03:05:54,956 [salt.state       ][INFO    ][24190] Completed state [python-psutil] at time 03:05:54.956357 duration_in_ms=2.775
2017-09-25 03:05:54,957 [salt.state       ][INFO    ][24190] Running state [python-m2crypto] at time 03:05:54.956493
2017-09-25 03:05:54,957 [salt.state       ][INFO    ][24190] Executing state pkg.installed for python-m2crypto
2017-09-25 03:05:54,959 [salt.state       ][INFO    ][24190] Package python-m2crypto is already installed
2017-09-25 03:05:54,959 [salt.state       ][INFO    ][24190] Completed state [python-m2crypto] at time 03:05:54.959235 duration_in_ms=2.742
2017-09-25 03:05:54,961 [salt.state       ][INFO    ][24190] Running state [/etc/salt/minion.d/minion.conf] at time 03:05:54.960693
2017-09-25 03:05:54,961 [salt.state       ][INFO    ][24190] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-25 03:05:54,989 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-25 03:05:55,038 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:05:55,086 [salt.fileclient  ][INFO    ][24190] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 03:05:55,118 [salt.state       ][INFO    ][24190] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-25 03:05:55,118 [salt.state       ][INFO    ][24190] Completed state [/etc/salt/minion.d/minion.conf] at time 03:05:55.118335 duration_in_ms=157.641
2017-09-25 03:05:55,119 [salt.state       ][INFO    ][24190] Running state [/etc/salt/minion.d/_virt.conf] at time 03:05:55.118650
2017-09-25 03:05:55,119 [salt.state       ][INFO    ][24190] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-25 03:05:55,197 [salt.state       ][INFO    ][24190] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-25 03:05:55,198 [salt.state       ][INFO    ][24190] Completed state [/etc/salt/minion.d/_virt.conf] at time 03:05:55.197496 duration_in_ms=78.846
2017-09-25 03:05:55,199 [salt.state       ][INFO    ][24190] Running state [salt-minion] at time 03:05:55.198588
2017-09-25 03:05:55,199 [salt.state       ][INFO    ][24190] Executing state service.running for salt-minion
2017-09-25 03:05:55,199 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-25 03:05:55,218 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-25 03:05:55,226 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-25 03:05:55,234 [salt.state       ][INFO    ][24190] The service salt-minion is already running
2017-09-25 03:05:55,235 [salt.state       ][INFO    ][24190] Completed state [salt-minion] at time 03:05:55.234583 duration_in_ms=35.993
2017-09-25 03:05:55,236 [salt.state       ][INFO    ][24190] Running state [/etc/salt/grains.d] at time 03:05:55.235802
2017-09-25 03:05:55,236 [salt.state       ][INFO    ][24190] Executing state file.directory for /etc/salt/grains.d
2017-09-25 03:05:55,237 [salt.state       ][INFO    ][24190] Directory /etc/salt/grains.d is in the correct state
2017-09-25 03:05:55,237 [salt.state       ][INFO    ][24190] Completed state [/etc/salt/grains.d] at time 03:05:55.236812 duration_in_ms=1.01
2017-09-25 03:05:55,237 [salt.state       ][INFO    ][24190] Running state [/etc/salt/grains] at time 03:05:55.237301
2017-09-25 03:05:55,238 [salt.state       ][INFO    ][24190] Executing state file.managed for /etc/salt/grains
2017-09-25 03:05:55,238 [salt.state       ][INFO    ][24190] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-25 03:05:55,238 [salt.state       ][INFO    ][24190] Completed state [/etc/salt/grains] at time 03:05:55.238068 duration_in_ms=0.767
2017-09-25 03:05:55,238 [salt.state       ][INFO    ][24190] Running state [/etc/salt/grains.d/placeholder] at time 03:05:55.238370
2017-09-25 03:05:55,239 [salt.state       ][INFO    ][24190] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-25 03:05:55,239 [salt.state       ][INFO    ][24190] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-25 03:05:55,239 [salt.state       ][INFO    ][24190] Completed state [/etc/salt/grains.d/placeholder] at time 03:05:55.239108 duration_in_ms=0.737
2017-09-25 03:05:55,239 [salt.state       ][INFO    ][24190] Running state [/etc/salt/grains.d/sphinx] at time 03:05:55.239422
2017-09-25 03:05:55,240 [salt.state       ][INFO    ][24190] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-25 03:05:55,269 [salt.state       ][INFO    ][24190] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.143
               - 127.0.0.1
               - 192.168.11.252
-              - 192.168.122.1
         system:
           name: System
           param:

2017-09-25 03:05:55,270 [salt.state       ][INFO    ][24190] Completed state [/etc/salt/grains.d/sphinx] at time 03:05:55.269655 duration_in_ms=30.233
2017-09-25 03:05:55,270 [salt.state       ][INFO    ][24190] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:05:55.270257
2017-09-25 03:05:55,271 [salt.state       ][INFO    ][24190] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:05:55,271 [salt.state       ][INFO    ][24190] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:05:55,271 [salt.state       ][INFO    ][24190] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:05:55.270882 duration_in_ms=0.625
2017-09-25 03:05:55,271 [salt.state       ][INFO    ][24190] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:05:55.271021
2017-09-25 03:05:55,271 [salt.state       ][INFO    ][24190] 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-25 03:05:55,272 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-09-25 03:05:55,358 [salt.state       ][INFO    ][24190] {'pid': 24239, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-09-25 03:05:55,358 [salt.state       ][INFO    ][24190] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:05:55.358207 duration_in_ms=87.184
2017-09-25 03:05:55,359 [salt.state       ][INFO    ][24190] Running state [/etc/salt/grains.d/dns_records] at time 03:05:55.358850
2017-09-25 03:05:55,359 [salt.state       ][INFO    ][24190] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-25 03:05:55,396 [salt.state       ][INFO    ][24190] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-25 03:05:55,397 [salt.state       ][INFO    ][24190] Completed state [/etc/salt/grains.d/dns_records] at time 03:05:55.396572 duration_in_ms=37.722
2017-09-25 03:05:55,397 [salt.state       ][INFO    ][24190] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 03:05:55.397120
2017-09-25 03:05:55,397 [salt.state       ][INFO    ][24190] 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-25 03:05:55,398 [salt.state       ][INFO    ][24190] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:05:55,398 [salt.state       ][INFO    ][24190] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 03:05:55.397789 duration_in_ms=0.669
2017-09-25 03:05:55,398 [salt.state       ][INFO    ][24190] Running state [/etc/salt/grains.d/salt] at time 03:05:55.398112
2017-09-25 03:05:55,398 [salt.state       ][INFO    ][24190] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-25 03:05:55,420 [salt.state       ][INFO    ][24190] File /etc/salt/grains.d/salt is in the correct state
2017-09-25 03:05:55,421 [salt.state       ][INFO    ][24190] Completed state [/etc/salt/grains.d/salt] at time 03:05:55.420575 duration_in_ms=22.463
2017-09-25 03:05:55,421 [salt.state       ][INFO    ][24190] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 03:05:55.421076
2017-09-25 03:05:55,421 [salt.state       ][INFO    ][24190] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:05:55,422 [salt.state       ][INFO    ][24190] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:05:55,422 [salt.state       ][INFO    ][24190] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 03:05:55.421729 duration_in_ms=0.653
2017-09-25 03:05:55,423 [salt.state       ][INFO    ][24190] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:05:55.423001
2017-09-25 03:05:55,423 [salt.state       ][INFO    ][24190] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-25 03:05:55,423 [salt.state       ][INFO    ][24190] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-25 03:05:55,424 [salt.state       ][INFO    ][24190] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:05:55.423631 duration_in_ms=0.63
2017-09-25 03:05:55,424 [salt.state       ][INFO    ][24190] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:05:55.423792
2017-09-25 03:05:55,424 [salt.state       ][INFO    ][24190] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-25 03:05:55,425 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-09-25 03:05:55,434 [salt.state       ][INFO    ][24190] {'pid': 24241, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-09-25 03:05:55,435 [salt.state       ][INFO    ][24190] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:05:55.434536 duration_in_ms=10.744
2017-09-25 03:05:55,435 [salt.state       ][INFO    ][24190] Running state [mine.update] at time 03:05:55.435185
2017-09-25 03:05:55,435 [salt.state       ][INFO    ][24190] Executing state module.wait for mine.update
2017-09-25 03:05:55,436 [salt.state       ][INFO    ][24190] No changes made for mine.update
2017-09-25 03:05:55,436 [salt.state       ][INFO    ][24190] Completed state [mine.update] at time 03:05:55.435765 duration_in_ms=0.579
2017-09-25 03:05:55,436 [salt.state       ][INFO    ][24190] Running state [mine.update] at time 03:05:55.435909
2017-09-25 03:05:55,436 [salt.state       ][INFO    ][24190] Executing state module.mod_watch for mine.update
2017-09-25 03:05:55,959 [salt.state       ][INFO    ][24190] {'ret': True}
2017-09-25 03:05:55,959 [salt.state       ][INFO    ][24190] Completed state [mine.update] at time 03:05:55.958879 duration_in_ms=522.969
2017-09-25 03:05:55,959 [salt.state       ][INFO    ][24190] Running state [ca-certificates] at time 03:05:55.959151
2017-09-25 03:05:55,959 [salt.state       ][INFO    ][24190] Executing state pkg.installed for ca-certificates
2017-09-25 03:05:55,963 [salt.state       ][INFO    ][24190] Package ca-certificates is already installed
2017-09-25 03:05:55,963 [salt.state       ][INFO    ][24190] Completed state [ca-certificates] at time 03:05:55.962858 duration_in_ms=3.707
2017-09-25 03:05:55,963 [salt.state       ][INFO    ][24190] Running state [update-ca-certificates] at time 03:05:55.963438
2017-09-25 03:05:55,964 [salt.state       ][INFO    ][24190] Executing state cmd.wait for update-ca-certificates
2017-09-25 03:05:55,964 [salt.state       ][INFO    ][24190] No changes made for update-ca-certificates
2017-09-25 03:05:55,964 [salt.state       ][INFO    ][24190] Completed state [update-ca-certificates] at time 03:05:55.964072 duration_in_ms=0.633
2017-09-25 03:05:55,964 [salt.state       ][INFO    ][24190] Running state [libvirt-dev] at time 03:05:55.964268
2017-09-25 03:05:55,964 [salt.state       ][INFO    ][24190] Executing state pkg.installed for libvirt-dev
2017-09-25 03:05:55,967 [salt.state       ][INFO    ][24190] Package libvirt-dev is already installed
2017-09-25 03:05:55,967 [salt.state       ][INFO    ][24190] Completed state [libvirt-dev] at time 03:05:55.967381 duration_in_ms=3.113
2017-09-25 03:05:55,968 [salt.state       ][INFO    ][24190] Running state [pkg-config] at time 03:05:55.967575
2017-09-25 03:05:55,968 [salt.state       ][INFO    ][24190] Executing state pkg.installed for pkg-config
2017-09-25 03:05:55,971 [salt.state       ][INFO    ][24190] Package pkg-config is already installed
2017-09-25 03:05:55,971 [salt.state       ][INFO    ][24190] Completed state [pkg-config] at time 03:05:55.970701 duration_in_ms=3.126
2017-09-25 03:05:55,971 [salt.state       ][INFO    ][24190] Running state [virtng.init] at time 03:05:55.970900
2017-09-25 03:05:55,971 [salt.state       ][INFO    ][24190] Executing state module.run for virtng.init
2017-09-25 03:05:56,030 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command ['git', '--version'] in directory '/root'
2017-09-25 03:05:56,134 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:05:56,150 [salt.state       ][INFO    ][24190] unless execution succeeded
2017-09-25 03:05:56,151 [salt.state       ][INFO    ][24190] Completed state [virtng.init] at time 03:05:56.150576 duration_in_ms=179.675
2017-09-25 03:05:56,151 [salt.state       ][INFO    ][24190] Running state [virt.set_autostart] at time 03:05:56.150813
2017-09-25 03:05:56,151 [salt.state       ][INFO    ][24190] Executing state module.run for virt.set_autostart
2017-09-25 03:05:56,153 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:05:56,168 [salt.state       ][INFO    ][24190] unless execution succeeded
2017-09-25 03:05:56,169 [salt.state       ][INFO    ][24190] Completed state [virt.set_autostart] at time 03:05:56.168709 duration_in_ms=17.896
2017-09-25 03:05:56,169 [salt.state       ][INFO    ][24190] Running state [virtng.init] at time 03:05:56.168920
2017-09-25 03:05:56,169 [salt.state       ][INFO    ][24190] Executing state module.run for virtng.init
2017-09-25 03:05:56,171 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:05:56,185 [salt.state       ][INFO    ][24190] unless execution succeeded
2017-09-25 03:05:56,185 [salt.state       ][INFO    ][24190] Completed state [virtng.init] at time 03:05:56.185450 duration_in_ms=16.529
2017-09-25 03:05:56,186 [salt.state       ][INFO    ][24190] Running state [virt.set_autostart] at time 03:05:56.185698
2017-09-25 03:05:56,186 [salt.state       ][INFO    ][24190] Executing state module.run for virt.set_autostart
2017-09-25 03:05:56,188 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:05:56,208 [salt.state       ][INFO    ][24190] unless execution succeeded
2017-09-25 03:05:56,208 [salt.state       ][INFO    ][24190] Completed state [virt.set_autostart] at time 03:05:56.207796 duration_in_ms=22.098
2017-09-25 03:05:56,208 [salt.state       ][INFO    ][24190] Running state [virtng.init] at time 03:05:56.208002
2017-09-25 03:05:56,208 [salt.state       ][INFO    ][24190] Executing state module.run for virtng.init
2017-09-25 03:05:56,210 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'virsh list --all --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:05:56,224 [salt.state       ][INFO    ][24190] unless execution succeeded
2017-09-25 03:05:56,242 [salt.state       ][INFO    ][24190] Completed state [virtng.init] at time 03:05:56.241636 duration_in_ms=33.632
2017-09-25 03:05:56,242 [salt.state       ][INFO    ][24190] Running state [virt.set_autostart] at time 03:05:56.242072
2017-09-25 03:05:56,242 [salt.state       ][INFO    ][24190] Executing state module.run for virt.set_autostart
2017-09-25 03:05:56,244 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'virsh list --autostart --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:05:56,260 [salt.state       ][INFO    ][24190] unless execution succeeded
2017-09-25 03:05:56,260 [salt.state       ][INFO    ][24190] Completed state [virt.set_autostart] at time 03:05:56.260207 duration_in_ms=18.135
2017-09-25 03:05:56,260 [salt.state       ][INFO    ][24190] Running state [virtng.init] at time 03:05:56.260416
2017-09-25 03:05:56,261 [salt.state       ][INFO    ][24190] Executing state module.run for virtng.init
2017-09-25 03:05:56,263 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:05:56,277 [salt.state       ][INFO    ][24190] unless execution succeeded
2017-09-25 03:05:56,277 [salt.state       ][INFO    ][24190] Completed state [virtng.init] at time 03:05:56.277288 duration_in_ms=16.87
2017-09-25 03:05:56,278 [salt.state       ][INFO    ][24190] Running state [virt.set_autostart] at time 03:05:56.277500
2017-09-25 03:05:56,278 [salt.state       ][INFO    ][24190] Executing state module.run for virt.set_autostart
2017-09-25 03:05:56,280 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:05:56,294 [salt.state       ][INFO    ][24190] unless execution succeeded
2017-09-25 03:05:56,295 [salt.state       ][INFO    ][24190] Completed state [virt.set_autostart] at time 03:05:56.294652 duration_in_ms=17.151
2017-09-25 03:05:56,295 [salt.state       ][INFO    ][24190] Running state [virtng.init] at time 03:05:56.294866
2017-09-25 03:05:56,295 [salt.state       ][INFO    ][24190] Executing state module.run for virtng.init
2017-09-25 03:05:56,297 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:05:56,312 [salt.state       ][INFO    ][24190] unless execution succeeded
2017-09-25 03:05:56,320 [salt.state       ][INFO    ][24190] Completed state [virtng.init] at time 03:05:56.319598 duration_in_ms=24.73
2017-09-25 03:05:56,320 [salt.state       ][INFO    ][24190] Running state [virt.set_autostart] at time 03:05:56.319831
2017-09-25 03:05:56,320 [salt.state       ][INFO    ][24190] Executing state module.run for virt.set_autostart
2017-09-25 03:05:56,322 [salt.loaded.int.module.cmdmod][INFO    ][24190] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:05:56,336 [salt.state       ][INFO    ][24190] unless execution succeeded
2017-09-25 03:05:56,336 [salt.state       ][INFO    ][24190] Completed state [virt.set_autostart] at time 03:05:56.336213 duration_in_ms=16.382
2017-09-25 03:05:56,339 [salt.minion      ][INFO    ][24190] Returning information for job: 20170925030551759844
2017-09-25 03:06:22,998 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command state.sls with jid 20170925030622987743
2017-09-25 03:06:23,012 [salt.minion      ][INFO    ][24303] Starting a new job with PID 24303
2017-09-25 03:06:25,460 [salt.state       ][INFO    ][24303] Loading fresh modules for state activity
2017-09-25 03:06:25,485 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-25 03:06:25,503 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-25 03:06:25,564 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:06:25,629 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-25 03:06:25,643 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-25 03:06:25,668 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:06:25,722 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-25 03:06:25,738 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 03:06:25,780 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-25 03:06:25,850 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-25 03:06:25,864 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 03:06:25,879 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-25 03:06:25,885 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-25 03:06:25,908 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-25 03:06:25,922 [py.warnings      ][WARNING ][24303] /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-25 03:06:25,922 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'salt-minion --version' in directory '/root'
2017-09-25 03:06:26,194 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-25 03:06:26,212 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-25 03:06:26,222 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-25 03:06:26,233 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-25 03:06:26,289 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-25 03:06:26,333 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-25 03:06:26,385 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-25 03:06:26,405 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:06:26,457 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-25 03:06:26,475 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 03:06:26,516 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-25 03:06:26,534 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-25 03:06:26,547 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 03:06:26,564 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-25 03:06:26,572 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-25 03:06:26,595 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-25 03:06:26,608 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'salt-minion --version' in directory '/root'
2017-09-25 03:06:26,858 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-25 03:06:26,878 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-25 03:06:26,890 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-25 03:06:26,903 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-25 03:06:26,967 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-25 03:06:27,003 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-25 03:06:27,064 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-25 03:06:27,120 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:06:27,462 [salt.state       ][INFO    ][24303] Running state [salt-minion] at time 03:06:27.462160
2017-09-25 03:06:27,462 [salt.state       ][INFO    ][24303] Executing state pkg.installed for salt-minion
2017-09-25 03:06:27,463 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:06:27,735 [salt.state       ][INFO    ][24303] Package salt-minion is already installed
2017-09-25 03:06:27,735 [salt.state       ][INFO    ][24303] Completed state [salt-minion] at time 03:06:27.735290 duration_in_ms=273.131
2017-09-25 03:06:27,736 [salt.state       ][INFO    ][24303] Running state [python-yaml] at time 03:06:27.735587
2017-09-25 03:06:27,736 [salt.state       ][INFO    ][24303] Executing state pkg.installed for python-yaml
2017-09-25 03:06:27,738 [salt.state       ][INFO    ][24303] Package python-yaml is already installed
2017-09-25 03:06:27,739 [salt.state       ][INFO    ][24303] Completed state [python-yaml] at time 03:06:27.738609 duration_in_ms=3.022
2017-09-25 03:06:27,739 [salt.state       ][INFO    ][24303] Running state [python-psutil] at time 03:06:27.738816
2017-09-25 03:06:27,739 [salt.state       ][INFO    ][24303] Executing state pkg.installed for python-psutil
2017-09-25 03:06:27,742 [salt.state       ][INFO    ][24303] Package python-psutil is already installed
2017-09-25 03:06:27,742 [salt.state       ][INFO    ][24303] Completed state [python-psutil] at time 03:06:27.741936 duration_in_ms=3.12
2017-09-25 03:06:27,742 [salt.state       ][INFO    ][24303] Running state [python-m2crypto] at time 03:06:27.742140
2017-09-25 03:06:27,742 [salt.state       ][INFO    ][24303] Executing state pkg.installed for python-m2crypto
2017-09-25 03:06:27,745 [salt.state       ][INFO    ][24303] Package python-m2crypto is already installed
2017-09-25 03:06:27,745 [salt.state       ][INFO    ][24303] Completed state [python-m2crypto] at time 03:06:27.745084 duration_in_ms=2.944
2017-09-25 03:06:27,747 [salt.state       ][INFO    ][24303] Running state [/etc/salt/minion.d/minion.conf] at time 03:06:27.746662
2017-09-25 03:06:27,747 [salt.state       ][INFO    ][24303] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-25 03:06:27,769 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-25 03:06:27,860 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 03:06:27,923 [salt.fileclient  ][INFO    ][24303] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 03:06:27,955 [salt.state       ][INFO    ][24303] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-25 03:06:27,955 [salt.state       ][INFO    ][24303] Completed state [/etc/salt/minion.d/minion.conf] at time 03:06:27.955196 duration_in_ms=208.533
2017-09-25 03:06:27,956 [salt.state       ][INFO    ][24303] Running state [/etc/salt/minion.d/_virt.conf] at time 03:06:27.955528
2017-09-25 03:06:27,956 [salt.state       ][INFO    ][24303] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-25 03:06:28,061 [salt.state       ][INFO    ][24303] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-25 03:06:28,061 [salt.state       ][INFO    ][24303] Completed state [/etc/salt/minion.d/_virt.conf] at time 03:06:28.060929 duration_in_ms=105.4
2017-09-25 03:06:28,062 [salt.state       ][INFO    ][24303] Running state [salt-minion] at time 03:06:28.062197
2017-09-25 03:06:28,062 [salt.state       ][INFO    ][24303] Executing state service.running for salt-minion
2017-09-25 03:06:28,063 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-25 03:06:28,082 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-25 03:06:28,097 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-25 03:06:28,106 [salt.state       ][INFO    ][24303] The service salt-minion is already running
2017-09-25 03:06:28,106 [salt.state       ][INFO    ][24303] Completed state [salt-minion] at time 03:06:28.106166 duration_in_ms=43.967
2017-09-25 03:06:28,107 [salt.state       ][INFO    ][24303] Running state [/etc/salt/grains.d] at time 03:06:28.107350
2017-09-25 03:06:28,108 [salt.state       ][INFO    ][24303] Executing state file.directory for /etc/salt/grains.d
2017-09-25 03:06:28,108 [salt.state       ][INFO    ][24303] Directory /etc/salt/grains.d is in the correct state
2017-09-25 03:06:28,108 [salt.state       ][INFO    ][24303] Completed state [/etc/salt/grains.d] at time 03:06:28.108332 duration_in_ms=0.982
2017-09-25 03:06:28,109 [salt.state       ][INFO    ][24303] Running state [/etc/salt/grains] at time 03:06:28.108826
2017-09-25 03:06:28,109 [salt.state       ][INFO    ][24303] Executing state file.managed for /etc/salt/grains
2017-09-25 03:06:28,109 [salt.state       ][INFO    ][24303] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-25 03:06:28,110 [salt.state       ][INFO    ][24303] Completed state [/etc/salt/grains] at time 03:06:28.109608 duration_in_ms=0.781
2017-09-25 03:06:28,110 [salt.state       ][INFO    ][24303] Running state [/etc/salt/grains.d/placeholder] at time 03:06:28.109904
2017-09-25 03:06:28,110 [salt.state       ][INFO    ][24303] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-25 03:06:28,110 [salt.state       ][INFO    ][24303] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-25 03:06:28,111 [salt.state       ][INFO    ][24303] Completed state [/etc/salt/grains.d/placeholder] at time 03:06:28.110576 duration_in_ms=0.672
2017-09-25 03:06:28,111 [salt.state       ][INFO    ][24303] Running state [/etc/salt/grains.d/sphinx] at time 03:06:28.110887
2017-09-25 03:06:28,111 [salt.state       ][INFO    ][24303] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-25 03:06:28,232 [salt.state       ][INFO    ][24303] File /etc/salt/grains.d/sphinx is in the correct state
2017-09-25 03:06:28,232 [salt.state       ][INFO    ][24303] Completed state [/etc/salt/grains.d/sphinx] at time 03:06:28.231697 duration_in_ms=120.809
2017-09-25 03:06:28,233 [salt.state       ][INFO    ][24303] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:06:28.232513
2017-09-25 03:06:28,233 [salt.state       ][INFO    ][24303] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:06:28,233 [salt.state       ][INFO    ][24303] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:06:28,233 [salt.state       ][INFO    ][24303] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:06:28.233408 duration_in_ms=0.896
2017-09-25 03:06:28,234 [salt.state       ][INFO    ][24303] Running state [/etc/salt/grains.d/dns_records] at time 03:06:28.233777
2017-09-25 03:06:28,234 [salt.state       ][INFO    ][24303] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-25 03:06:28,302 [salt.state       ][INFO    ][24303] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-25 03:06:28,302 [salt.state       ][INFO    ][24303] Completed state [/etc/salt/grains.d/dns_records] at time 03:06:28.301882 duration_in_ms=68.105
2017-09-25 03:06:28,302 [salt.state       ][INFO    ][24303] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 03:06:28.302419
2017-09-25 03:06:28,303 [salt.state       ][INFO    ][24303] 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-25 03:06:28,303 [salt.state       ][INFO    ][24303] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:06:28,303 [salt.state       ][INFO    ][24303] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 03:06:28.302918 duration_in_ms=0.499
2017-09-25 03:06:28,303 [salt.state       ][INFO    ][24303] Running state [/etc/salt/grains.d/salt] at time 03:06:28.303181
2017-09-25 03:06:28,303 [salt.state       ][INFO    ][24303] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-25 03:06:28,410 [salt.state       ][INFO    ][24303] File /etc/salt/grains.d/salt is in the correct state
2017-09-25 03:06:28,410 [salt.state       ][INFO    ][24303] Completed state [/etc/salt/grains.d/salt] at time 03:06:28.409801 duration_in_ms=106.62
2017-09-25 03:06:28,410 [salt.state       ][INFO    ][24303] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 03:06:28.410276
2017-09-25 03:06:28,410 [salt.state       ][INFO    ][24303] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:06:28,411 [salt.state       ][INFO    ][24303] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-25 03:06:28,411 [salt.state       ][INFO    ][24303] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 03:06:28.410780 duration_in_ms=0.504
2017-09-25 03:06:28,412 [salt.state       ][INFO    ][24303] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:06:28.411935
2017-09-25 03:06:28,412 [salt.state       ][INFO    ][24303] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-25 03:06:28,412 [salt.state       ][INFO    ][24303] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-25 03:06:28,412 [salt.state       ][INFO    ][24303] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:06:28.412393 duration_in_ms=0.458
2017-09-25 03:06:28,413 [salt.state       ][INFO    ][24303] Running state [mine.update] at time 03:06:28.412772
2017-09-25 03:06:28,413 [salt.state       ][INFO    ][24303] Executing state module.wait for mine.update
2017-09-25 03:06:28,413 [salt.state       ][INFO    ][24303] No changes made for mine.update
2017-09-25 03:06:28,413 [salt.state       ][INFO    ][24303] Completed state [mine.update] at time 03:06:28.413195 duration_in_ms=0.422
2017-09-25 03:06:28,413 [salt.state       ][INFO    ][24303] Running state [ca-certificates] at time 03:06:28.413328
2017-09-25 03:06:28,413 [salt.state       ][INFO    ][24303] Executing state pkg.installed for ca-certificates
2017-09-25 03:06:28,416 [salt.state       ][INFO    ][24303] Package ca-certificates is already installed
2017-09-25 03:06:28,416 [salt.state       ][INFO    ][24303] Completed state [ca-certificates] at time 03:06:28.416462 duration_in_ms=3.135
2017-09-25 03:06:28,417 [salt.state       ][INFO    ][24303] Running state [update-ca-certificates] at time 03:06:28.416864
2017-09-25 03:06:28,417 [salt.state       ][INFO    ][24303] Executing state cmd.wait for update-ca-certificates
2017-09-25 03:06:28,417 [salt.state       ][INFO    ][24303] No changes made for update-ca-certificates
2017-09-25 03:06:28,417 [salt.state       ][INFO    ][24303] Completed state [update-ca-certificates] at time 03:06:28.417311 duration_in_ms=0.446
2017-09-25 03:06:28,417 [salt.state       ][INFO    ][24303] Running state [libvirt-dev] at time 03:06:28.417442
2017-09-25 03:06:28,418 [salt.state       ][INFO    ][24303] Executing state pkg.installed for libvirt-dev
2017-09-25 03:06:28,420 [salt.state       ][INFO    ][24303] Package libvirt-dev is already installed
2017-09-25 03:06:28,420 [salt.state       ][INFO    ][24303] Completed state [libvirt-dev] at time 03:06:28.420237 duration_in_ms=2.794
2017-09-25 03:06:28,420 [salt.state       ][INFO    ][24303] Running state [pkg-config] at time 03:06:28.420369
2017-09-25 03:06:28,421 [salt.state       ][INFO    ][24303] Executing state pkg.installed for pkg-config
2017-09-25 03:06:28,423 [salt.state       ][INFO    ][24303] Package pkg-config is already installed
2017-09-25 03:06:28,423 [salt.state       ][INFO    ][24303] Completed state [pkg-config] at time 03:06:28.423150 duration_in_ms=2.78
2017-09-25 03:06:28,423 [salt.state       ][INFO    ][24303] Running state [virtng.init] at time 03:06:28.423284
2017-09-25 03:06:28,423 [salt.state       ][INFO    ][24303] Executing state module.run for virtng.init
2017-09-25 03:06:28,467 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command ['git', '--version'] in directory '/root'
2017-09-25 03:06:28,872 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:28,890 [salt.state       ][INFO    ][24303] unless execution succeeded
2017-09-25 03:06:28,890 [salt.state       ][INFO    ][24303] Completed state [virtng.init] at time 03:06:28.890409 duration_in_ms=467.122
2017-09-25 03:06:28,891 [salt.state       ][INFO    ][24303] Running state [virt.set_autostart] at time 03:06:28.890641
2017-09-25 03:06:28,891 [salt.state       ][INFO    ][24303] Executing state module.run for virt.set_autostart
2017-09-25 03:06:28,893 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:28,911 [salt.state       ][INFO    ][24303] unless execution succeeded
2017-09-25 03:06:28,912 [salt.state       ][INFO    ][24303] Completed state [virt.set_autostart] at time 03:06:28.911682 duration_in_ms=21.041
2017-09-25 03:06:28,912 [salt.state       ][INFO    ][24303] Running state [virtng.init] at time 03:06:28.911895
2017-09-25 03:06:28,912 [salt.state       ][INFO    ][24303] Executing state module.run for virtng.init
2017-09-25 03:06:28,914 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:28,930 [salt.state       ][INFO    ][24303] unless execution succeeded
2017-09-25 03:06:28,930 [salt.state       ][INFO    ][24303] Completed state [virtng.init] at time 03:06:28.929886 duration_in_ms=17.99
2017-09-25 03:06:28,930 [salt.state       ][INFO    ][24303] Running state [virt.set_autostart] at time 03:06:28.930102
2017-09-25 03:06:28,930 [salt.state       ][INFO    ][24303] Executing state module.run for virt.set_autostart
2017-09-25 03:06:28,932 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:28,947 [salt.state       ][INFO    ][24303] unless execution succeeded
2017-09-25 03:06:28,947 [salt.state       ][INFO    ][24303] Completed state [virt.set_autostart] at time 03:06:28.947286 duration_in_ms=17.183
2017-09-25 03:06:28,948 [salt.state       ][INFO    ][24303] Running state [virtng.init] at time 03:06:28.947505
2017-09-25 03:06:28,948 [salt.state       ][INFO    ][24303] Executing state module.run for virtng.init
2017-09-25 03:06:28,950 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'virsh list --all --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:28,967 [salt.state       ][INFO    ][24303] unless execution succeeded
2017-09-25 03:06:28,967 [salt.state       ][INFO    ][24303] Completed state [virtng.init] at time 03:06:28.966702 duration_in_ms=19.196
2017-09-25 03:06:28,967 [salt.state       ][INFO    ][24303] Running state [virt.set_autostart] at time 03:06:28.966919
2017-09-25 03:06:28,967 [salt.state       ][INFO    ][24303] Executing state module.run for virt.set_autostart
2017-09-25 03:06:28,969 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'virsh list --autostart --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:28,985 [salt.state       ][INFO    ][24303] unless execution succeeded
2017-09-25 03:06:29,083 [salt.state       ][INFO    ][24303] Completed state [virt.set_autostart] at time 03:06:29.082808 duration_in_ms=115.888
2017-09-25 03:06:29,083 [salt.state       ][INFO    ][24303] Running state [virtng.init] at time 03:06:29.083089
2017-09-25 03:06:29,083 [salt.state       ][INFO    ][24303] Executing state module.run for virtng.init
2017-09-25 03:06:29,085 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:29,102 [salt.state       ][INFO    ][24303] unless execution succeeded
2017-09-25 03:06:29,102 [salt.state       ][INFO    ][24303] Completed state [virtng.init] at time 03:06:29.102239 duration_in_ms=19.15
2017-09-25 03:06:29,103 [salt.state       ][INFO    ][24303] Running state [virt.set_autostart] at time 03:06:29.102506
2017-09-25 03:06:29,103 [salt.state       ][INFO    ][24303] Executing state module.run for virt.set_autostart
2017-09-25 03:06:29,105 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:29,120 [salt.state       ][INFO    ][24303] unless execution succeeded
2017-09-25 03:06:29,120 [salt.state       ][INFO    ][24303] Completed state [virt.set_autostart] at time 03:06:29.119821 duration_in_ms=17.315
2017-09-25 03:06:29,120 [salt.state       ][INFO    ][24303] Running state [virtng.init] at time 03:06:29.120049
2017-09-25 03:06:29,120 [salt.state       ][INFO    ][24303] Executing state module.run for virtng.init
2017-09-25 03:06:29,122 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:29,137 [salt.state       ][INFO    ][24303] unless execution succeeded
2017-09-25 03:06:29,137 [salt.state       ][INFO    ][24303] Completed state [virtng.init] at time 03:06:29.137263 duration_in_ms=17.213
2017-09-25 03:06:29,138 [salt.state       ][INFO    ][24303] Running state [virt.set_autostart] at time 03:06:29.137491
2017-09-25 03:06:29,138 [salt.state       ][INFO    ][24303] Executing state module.run for virt.set_autostart
2017-09-25 03:06:29,140 [salt.loaded.int.module.cmdmod][INFO    ][24303] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-25 03:06:29,154 [salt.state       ][INFO    ][24303] unless execution succeeded
2017-09-25 03:06:29,154 [salt.state       ][INFO    ][24303] Completed state [virt.set_autostart] at time 03:06:29.154281 duration_in_ms=16.79
2017-09-25 03:06:29,157 [salt.minion      ][INFO    ][24303] Returning information for job: 20170925030622987743
2017-09-25 03:07:20,744 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170925030720732759
2017-09-25 03:07:20,763 [salt.minion      ][INFO    ][24402] Starting a new job with PID 24402
2017-09-25 03:07:23,858 [salt.state       ][INFO    ][24402] Loading fresh modules for state activity
2017-09-25 03:07:24,081 [salt.state       ][ERROR   ][24402] No contents found in top file
2017-09-25 03:07:24,082 [salt.utils.extmods][INFO    ][24402] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-25 03:07:24,085 [salt.utils.extmods][INFO    ][24402] Syncing beacons for environment 'base'
2017-09-25 03:07:24,085 [salt.utils.extmods][INFO    ][24402] Loading cache from salt://_beacons, for base)
2017-09-25 03:07:24,085 [salt.fileclient  ][INFO    ][24402] Caching directory '_beacons/' for environment 'base'
2017-09-25 03:07:24,106 [salt.utils.extmods][INFO    ][24402] Syncing modules for environment 'base'
2017-09-25 03:07:24,106 [salt.utils.extmods][INFO    ][24402] Loading cache from salt://_modules, for base)
2017-09-25 03:07:24,106 [salt.fileclient  ][INFO    ][24402] Caching directory '_modules/' for environment 'base'
2017-09-25 03:07:24,195 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-25 03:07:24,208 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-25 03:07:24,405 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-25 03:07:24,475 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-25 03:07:24,526 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-25 03:07:24,536 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-25 03:07:24,592 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-25 03:07:24,602 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-25 03:07:24,655 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-25 03:07:24,714 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-25 03:07:24,744 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-25 03:07:24,785 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-25 03:07:24,808 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-25 03:07:24,822 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-25 03:07:24,865 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-25 03:07:24,882 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-25 03:07:24,903 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-25 03:07:24,934 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-25 03:07:24,982 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-25 03:07:24,993 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-25 03:07:25,010 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-25 03:07:25,022 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-25 03:07:25,043 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-25 03:07:25,054 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-25 03:07:25,098 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-25 03:07:25,105 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-25 03:07:25,136 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-25 03:07:25,154 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-25 03:07:25,171 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-25 03:07:25,196 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-25 03:07:25,206 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-25 03:07:25,248 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-25 03:07:25,251 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-25 03:07:25,251 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-25 03:07:25,251 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-25 03:07:25,252 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-25 03:07:25,252 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-25 03:07:25,252 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-25 03:07:25,252 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-25 03:07:25,253 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-25 03:07:25,253 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-25 03:07:25,253 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-25 03:07:25,253 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-25 03:07:25,254 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-25 03:07:25,254 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-25 03:07:25,254 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-25 03:07:25,254 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-25 03:07:25,254 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-25 03:07:25,255 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-25 03:07:25,255 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-25 03:07:25,255 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-25 03:07:25,255 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-25 03:07:25,256 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-25 03:07:25,256 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-25 03:07:25,256 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-25 03:07:25,256 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-25 03:07:25,257 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-25 03:07:25,257 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-25 03:07:25,257 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-25 03:07:25,257 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-25 03:07:25,258 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-25 03:07:25,258 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-25 03:07:25,258 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-25 03:07:25,258 [salt.utils.extmods][INFO    ][24402] 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-25 03:07:25,258 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-25 03:07:25,259 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-25 03:07:25,263 [salt.utils.extmods][INFO    ][24402] Syncing states for environment 'base'
2017-09-25 03:07:25,263 [salt.utils.extmods][INFO    ][24402] Loading cache from salt://_states, for base)
2017-09-25 03:07:25,263 [salt.fileclient  ][INFO    ][24402] Caching directory '_states/' for environment 'base'
2017-09-25 03:07:25,343 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-25 03:07:25,352 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-25 03:07:25,361 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-25 03:07:25,371 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-25 03:07:25,383 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-25 03:07:25,409 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-25 03:07:25,437 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-25 03:07:25,458 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-25 03:07:25,529 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-25 03:07:25,540 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-25 03:07:25,571 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-25 03:07:25,585 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-25 03:07:25,623 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-25 03:07:25,639 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-25 03:07:25,654 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-25 03:07:25,664 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-25 03:07:25,677 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-25 03:07:25,691 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-25 03:07:25,723 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-25 03:07:25,731 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-25 03:07:25,763 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-25 03:07:25,778 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-25 03:07:25,912 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-25 03:07:25,940 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-25 03:07:25,988 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-25 03:07:26,021 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-25 03:07:26,058 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-25 03:07:26,072 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-25 03:07:26,094 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-25 03:07:26,098 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-25 03:07:26,098 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-25 03:07:26,099 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-25 03:07:26,099 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-25 03:07:26,099 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-25 03:07:26,100 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-25 03:07:26,100 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-25 03:07:26,100 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-25 03:07:26,100 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-25 03:07:26,100 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-25 03:07:26,101 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-25 03:07:26,101 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-25 03:07:26,101 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-25 03:07:26,102 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-25 03:07:26,102 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-25 03:07:26,102 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-25 03:07:26,102 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-25 03:07:26,103 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-25 03:07:26,103 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-25 03:07:26,103 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-25 03:07:26,103 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-25 03:07:26,103 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-25 03:07:26,103 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-25 03:07:26,104 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-25 03:07:26,104 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-25 03:07:26,104 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-25 03:07:26,104 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-25 03:07:26,104 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-25 03:07:26,105 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-25 03:07:26,105 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-25 03:07:26,107 [salt.utils.extmods][INFO    ][24402] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-25 03:07:26,109 [salt.utils.extmods][INFO    ][24402] Syncing sdb for environment 'base'
2017-09-25 03:07:26,110 [salt.utils.extmods][INFO    ][24402] Loading cache from salt://_sdb, for base)
2017-09-25 03:07:26,110 [salt.fileclient  ][INFO    ][24402] Caching directory '_sdb/' for environment 'base'
2017-09-25 03:07:26,142 [salt.utils.extmods][INFO    ][24402] Syncing grains for environment 'base'
2017-09-25 03:07:26,143 [salt.utils.extmods][INFO    ][24402] Loading cache from salt://_grains, for base)
2017-09-25 03:07:26,143 [salt.fileclient  ][INFO    ][24402] Caching directory '_grains/' for environment 'base'
2017-09-25 03:07:26,182 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-25 03:07:26,190 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-25 03:07:26,205 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-25 03:07:26,215 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-25 03:07:26,223 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-25 03:07:26,232 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-25 03:07:26,240 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-25 03:07:26,247 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-25 03:07:26,256 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-25 03:07:26,263 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-25 03:07:26,272 [salt.fileclient  ][INFO    ][24402] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-25 03:07:26,274 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-25 03:07:26,275 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-25 03:07:26,275 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-25 03:07:26,275 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-25 03:07:26,275 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-25 03:07:26,276 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-25 03:07:26,276 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-25 03:07:26,276 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-25 03:07:26,276 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-25 03:07:26,276 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-25 03:07:26,277 [salt.utils.extmods][INFO    ][24402] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-25 03:07:26,278 [salt.utils.extmods][INFO    ][24402] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-25 03:07:26,280 [salt.utils.extmods][INFO    ][24402] Syncing renderers for environment 'base'
2017-09-25 03:07:26,280 [salt.utils.extmods][INFO    ][24402] Loading cache from salt://_renderers, for base)
2017-09-25 03:07:26,280 [salt.fileclient  ][INFO    ][24402] Caching directory '_renderers/' for environment 'base'
2017-09-25 03:07:26,502 [salt.utils.extmods][INFO    ][24402] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-25 03:07:26,504 [salt.utils.extmods][INFO    ][24402] Syncing returners for environment 'base'
2017-09-25 03:07:26,504 [salt.utils.extmods][INFO    ][24402] Loading cache from salt://_returners, for base)
2017-09-25 03:07:26,504 [salt.fileclient  ][INFO    ][24402] Caching directory '_returners/' for environment 'base'
2017-09-25 03:07:26,548 [salt.utils.extmods][INFO    ][24402] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-25 03:07:26,551 [salt.utils.extmods][INFO    ][24402] Syncing output for environment 'base'
2017-09-25 03:07:26,551 [salt.utils.extmods][INFO    ][24402] Loading cache from salt://_output, for base)
2017-09-25 03:07:26,551 [salt.fileclient  ][INFO    ][24402] Caching directory '_output/' for environment 'base'
2017-09-25 03:07:26,574 [salt.utils.extmods][INFO    ][24402] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-25 03:07:26,576 [salt.utils.extmods][INFO    ][24402] Syncing utils for environment 'base'
2017-09-25 03:07:26,576 [salt.utils.extmods][INFO    ][24402] Loading cache from salt://_utils, for base)
2017-09-25 03:07:26,576 [salt.fileclient  ][INFO    ][24402] Caching directory '_utils/' for environment 'base'
2017-09-25 03:07:26,948 [salt.utils.extmods][INFO    ][24402] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-25 03:07:26,950 [salt.utils.extmods][INFO    ][24402] Syncing log_handlers for environment 'base'
2017-09-25 03:07:26,951 [salt.utils.extmods][INFO    ][24402] Loading cache from salt://_log_handlers, for base)
2017-09-25 03:07:26,951 [salt.fileclient  ][INFO    ][24402] Caching directory '_log_handlers/' for environment 'base'
2017-09-25 03:07:26,984 [salt.utils.extmods][INFO    ][24402] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-25 03:07:26,987 [salt.utils.extmods][INFO    ][24402] Syncing proxy for environment 'base'
2017-09-25 03:07:26,987 [salt.utils.extmods][INFO    ][24402] Loading cache from salt://_proxy, for base)
2017-09-25 03:07:26,987 [salt.fileclient  ][INFO    ][24402] Caching directory '_proxy/' for environment 'base'
2017-09-25 03:07:27,016 [salt.utils.extmods][INFO    ][24402] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-25 03:07:27,019 [salt.utils.extmods][INFO    ][24402] Syncing engines for environment 'base'
2017-09-25 03:07:27,019 [salt.utils.extmods][INFO    ][24402] Loading cache from salt://_engines, for base)
2017-09-25 03:07:27,019 [salt.fileclient  ][INFO    ][24402] Caching directory '_engines/' for environment 'base'
2017-09-25 03:07:27,047 [salt.minion      ][INFO    ][24402] Returning information for job: 20170925030720732759
2017-09-25 03:14:12,276 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command pkg.upgrade with jid 20170925031412265333
2017-09-25 03:14:12,294 [salt.minion      ][INFO    ][24579] Starting a new job with PID 24579
2017-09-25 03:14:12,308 [salt.loaded.int.module.cmdmod][INFO    ][24579] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:14:12,560 [salt.loaded.int.module.cmdmod][INFO    ][24579] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-09-25 03:14:22,319 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925031422305454
2017-09-25 03:14:22,336 [salt.minion      ][INFO    ][24630] Starting a new job with PID 24630
2017-09-25 03:14:22,345 [salt.minion      ][INFO    ][24630] Returning information for job: 20170925031422305454
2017-09-25 03:14:32,474 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925031432461809
2017-09-25 03:14:32,491 [salt.minion      ][INFO    ][24764] Starting a new job with PID 24764
2017-09-25 03:14:32,514 [salt.minion      ][INFO    ][24764] Returning information for job: 20170925031432461809
2017-09-25 03:14:42,553 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925031442541721
2017-09-25 03:14:42,571 [salt.minion      ][INFO    ][25318] Starting a new job with PID 25318
2017-09-25 03:14:42,626 [salt.minion      ][INFO    ][25318] Returning information for job: 20170925031442541721
2017-09-25 03:14:50,248 [salt.loaded.int.module.cmdmod][INFO    ][24579] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:14:50,269 [salt.minion      ][INFO    ][24579] Returning information for job: 20170925031412265333
2017-09-25 03:19:47,058 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command pkg.upgrade with jid 20170925031947046703
2017-09-25 03:19:47,072 [salt.minion      ][INFO    ][25495] Starting a new job with PID 25495
2017-09-25 03:19:47,139 [salt.loaded.int.module.cmdmod][INFO    ][25495] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:19:47,387 [salt.loaded.int.module.cmdmod][INFO    ][25495] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-09-25 03:19:47,619 [salt.loaded.int.module.cmdmod][INFO    ][25495] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:19:47,652 [salt.minion      ][INFO    ][25495] Returning information for job: 20170925031947046703
2017-09-25 03:20:18,232 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command pkg.upgrade with jid 20170925032018220154
2017-09-25 03:20:18,246 [salt.minion      ][INFO    ][25520] Starting a new job with PID 25520
2017-09-25 03:20:18,258 [salt.loaded.int.module.cmdmod][INFO    ][25520] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:20:18,503 [salt.loaded.int.module.cmdmod][INFO    ][25520] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-09-25 03:20:18,738 [salt.loaded.int.module.cmdmod][INFO    ][25520] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:20:18,758 [salt.minion      ][INFO    ][25520] Returning information for job: 20170925032018220154
2017-09-25 03:20:49,372 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command pkg.upgrade with jid 20170925032049357280
2017-09-25 03:20:49,392 [salt.minion      ][INFO    ][25562] Starting a new job with PID 25562
2017-09-25 03:20:49,405 [salt.loaded.int.module.cmdmod][INFO    ][25562] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:20:49,669 [salt.loaded.int.module.cmdmod][INFO    ][25562] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-09-25 03:20:49,940 [salt.loaded.int.module.cmdmod][INFO    ][25562] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:20:49,962 [salt.minion      ][INFO    ][25562] Returning information for job: 20170925032049357280
2017-09-25 03:21:20,724 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command pkg.upgrade with jid 20170925032120712631
2017-09-25 03:21:20,741 [salt.minion      ][INFO    ][25597] Starting a new job with PID 25597
2017-09-25 03:21:20,755 [salt.loaded.int.module.cmdmod][INFO    ][25597] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:21:21,030 [salt.loaded.int.module.cmdmod][INFO    ][25597] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-09-25 03:21:21,305 [salt.loaded.int.module.cmdmod][INFO    ][25597] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:21:21,341 [salt.minion      ][INFO    ][25597] Returning information for job: 20170925032120712631
2017-09-25 03:21:51,929 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command pkg.upgrade with jid 20170925032151914251
2017-09-25 03:21:51,946 [salt.minion      ][INFO    ][25634] Starting a new job with PID 25634
2017-09-25 03:21:51,961 [salt.loaded.int.module.cmdmod][INFO    ][25634] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:21:52,269 [salt.loaded.int.module.cmdmod][INFO    ][25634] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-09-25 03:21:52,602 [salt.loaded.int.module.cmdmod][INFO    ][25634] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:21:52,624 [salt.minion      ][INFO    ][25634] Returning information for job: 20170925032151914251
2017-09-25 03:33:54,289 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command test.ping with jid 20170925033354279047
2017-09-25 03:33:54,308 [salt.minion      ][INFO    ][25898] Starting a new job with PID 25898
2017-09-25 03:33:54,337 [salt.minion      ][INFO    ][25898] Returning information for job: 20170925033354279047
2017-09-25 03:34:27,847 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command state.sls with jid 20170925033427836395
2017-09-25 03:34:27,862 [salt.minion      ][INFO    ][25914] Starting a new job with PID 25914
2017-09-25 03:34:29,392 [salt.state       ][INFO    ][25914] Loading fresh modules for state activity
2017-09-25 03:34:29,418 [salt.fileclient  ][INFO    ][25914] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-25 03:34:29,435 [salt.fileclient  ][INFO    ][25914] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-25 03:34:29,460 [salt.fileclient  ][INFO    ][25914] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 03:34:29,769 [salt.state       ][INFO    ][25914] Running state [lsof] at time 03:34:29.768901
2017-09-25 03:34:29,769 [salt.state       ][INFO    ][25914] Executing state pkg.installed for lsof
2017-09-25 03:34:29,770 [salt.loaded.int.module.cmdmod][INFO    ][25914] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:34:30,037 [salt.state       ][INFO    ][25914] Package lsof is already installed
2017-09-25 03:34:30,038 [salt.state       ][INFO    ][25914] Completed state [lsof] at time 03:34:30.037688 duration_in_ms=268.786
2017-09-25 03:34:30,038 [salt.state       ][INFO    ][25914] Running state [keepalived] at time 03:34:30.037873
2017-09-25 03:34:30,038 [salt.state       ][INFO    ][25914] Executing state pkg.installed for keepalived
2017-09-25 03:34:30,054 [salt.loaded.int.module.cmdmod][INFO    ][25914] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-25 03:34:33,351 [salt.loaded.int.module.cmdmod][INFO    ][25914] 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-25 03:34:37,889 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925033437877688
2017-09-25 03:34:37,904 [salt.minion      ][INFO    ][27155] Starting a new job with PID 27155
2017-09-25 03:34:37,915 [salt.minion      ][INFO    ][27155] Returning information for job: 20170925033437877688
2017-09-25 03:34:40,885 [salt.loaded.int.module.cmdmod][INFO    ][25914] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:34:40,908 [salt.state       ][INFO    ][25914] 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-25 03:34:40,916 [salt.state       ][INFO    ][25914] Loading fresh modules for state activity
2017-09-25 03:34:40,928 [salt.state       ][INFO    ][25914] Completed state [keepalived] at time 03:34:40.928058 duration_in_ms=10890.184
2017-09-25 03:34:40,930 [salt.state       ][INFO    ][25914] Running state [/etc/keepalived/keepalived.conf] at time 03:34:40.930075
2017-09-25 03:34:40,930 [salt.state       ][INFO    ][25914] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-25 03:34:40,958 [salt.fileclient  ][INFO    ][25914] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-25 03:34:40,988 [salt.fileclient  ][INFO    ][25914] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 03:34:40,994 [salt.state       ][INFO    ][25914] File changed:
New file
2017-09-25 03:34:40,994 [salt.state       ][INFO    ][25914] Completed state [/etc/keepalived/keepalived.conf] at time 03:34:40.994443 duration_in_ms=64.366
2017-09-25 03:34:41,050 [salt.state       ][INFO    ][25914] Running state [keepalived] at time 03:34:41.049793
2017-09-25 03:34:41,050 [salt.state       ][INFO    ][25914] Executing state service.running for keepalived
2017-09-25 03:34:41,052 [salt.loaded.int.module.cmdmod][INFO    ][25914] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-25 03:34:41,063 [salt.loaded.int.module.cmdmod][INFO    ][25914] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-25 03:34:41,072 [salt.loaded.int.module.cmdmod][INFO    ][25914] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-25 03:34:41,080 [salt.loaded.int.module.cmdmod][INFO    ][25914] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-25 03:34:41,088 [salt.loaded.int.module.cmdmod][INFO    ][25914] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-25 03:34:41,165 [salt.loaded.int.module.cmdmod][INFO    ][25914] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-25 03:34:41,173 [salt.loaded.int.module.cmdmod][INFO    ][25914] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-25 03:34:41,181 [salt.loaded.int.module.cmdmod][INFO    ][25914] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-25 03:34:41,188 [salt.state       ][INFO    ][25914] {'keepalived': True}
2017-09-25 03:34:41,188 [salt.state       ][INFO    ][25914] Completed state [keepalived] at time 03:34:41.187983 duration_in_ms=138.189
2017-09-25 03:34:41,189 [salt.minion      ][INFO    ][25914] Returning information for job: 20170925033427836395
2017-09-25 03:38:11,191 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command pillar.get with jid 20170925033811178280
2017-09-25 03:38:11,211 [salt.minion      ][INFO    ][27519] Starting a new job with PID 27519
2017-09-25 03:38:11,214 [salt.minion      ][INFO    ][27519] Returning information for job: 20170925033811178280
2017-09-25 03:44:09,164 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command state.sls with jid 20170925034409153556
2017-09-25 03:44:09,180 [salt.minion      ][INFO    ][27637] Starting a new job with PID 27637
2017-09-25 03:44:10,602 [salt.state       ][INFO    ][27637] Loading fresh modules for state activity
2017-09-25 03:44:10,625 [salt.fileclient  ][INFO    ][27637] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-25 03:44:10,647 [salt.fileclient  ][INFO    ][27637] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-25 03:44:10,917 [salt.state       ][INFO    ][27637] Running state [attr] at time 03:44:10.917381
2017-09-25 03:44:10,918 [salt.state       ][INFO    ][27637] Executing state pkg.installed for attr
2017-09-25 03:44:10,918 [salt.loaded.int.module.cmdmod][INFO    ][27637] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:44:11,186 [salt.loaded.int.module.cmdmod][INFO    ][27637] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-25 03:44:13,183 [salt.loaded.int.module.cmdmod][INFO    ][27637] 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-25 03:44:16,035 [salt.loaded.int.module.cmdmod][INFO    ][27637] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:44:16,059 [salt.state       ][INFO    ][27637] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-25 03:44:16,067 [salt.state       ][INFO    ][27637] Loading fresh modules for state activity
2017-09-25 03:44:16,079 [salt.state       ][INFO    ][27637] Completed state [attr] at time 03:44:16.079184 duration_in_ms=5161.803
2017-09-25 03:44:16,084 [salt.state       ][INFO    ][27637] Running state [glusterfs-server] at time 03:44:16.084007
2017-09-25 03:44:16,084 [salt.state       ][INFO    ][27637] Executing state pkg.installed for glusterfs-server
2017-09-25 03:44:16,269 [salt.loaded.int.module.cmdmod][INFO    ][27637] 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-25 03:44:19,261 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925034419248438
2017-09-25 03:44:19,277 [salt.minion      ][INFO    ][28643] Starting a new job with PID 28643
2017-09-25 03:44:19,292 [salt.minion      ][INFO    ][28643] Returning information for job: 20170925034419248438
2017-09-25 03:44:29,469 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925034429456553
2017-09-25 03:44:29,483 [salt.minion      ][INFO    ][31463] Starting a new job with PID 31463
2017-09-25 03:44:29,495 [salt.minion      ][INFO    ][31463] Returning information for job: 20170925034429456553
2017-09-25 03:44:34,174 [salt.loaded.int.module.cmdmod][INFO    ][27637] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:44:34,200 [salt.state       ][INFO    ][27637] 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-25 03:44:34,207 [salt.state       ][INFO    ][27637] Loading fresh modules for state activity
2017-09-25 03:44:34,219 [salt.state       ][INFO    ][27637] Completed state [glusterfs-server] at time 03:44:34.219091 duration_in_ms=18135.083
2017-09-25 03:44:34,226 [salt.state       ][INFO    ][27637] Running state [bc] at time 03:44:34.225549
2017-09-25 03:44:34,226 [salt.state       ][INFO    ][27637] Executing state pkg.installed for bc
2017-09-25 03:44:34,487 [salt.loaded.int.module.cmdmod][INFO    ][27637] 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-25 03:44:37,259 [salt.loaded.int.module.cmdmod][INFO    ][27637] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:44:37,286 [salt.state       ][INFO    ][27637] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-25 03:44:37,295 [salt.state       ][INFO    ][27637] Loading fresh modules for state activity
2017-09-25 03:44:37,308 [salt.state       ][INFO    ][27637] Completed state [bc] at time 03:44:37.307989 duration_in_ms=3082.439
2017-09-25 03:44:37,373 [salt.state       ][INFO    ][27637] Running state [glusterfs-server] at time 03:44:37.373295
2017-09-25 03:44:37,374 [salt.state       ][INFO    ][27637] Executing state service.running for glusterfs-server
2017-09-25 03:44:37,376 [salt.loaded.int.module.cmdmod][INFO    ][27637] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-25 03:44:37,385 [salt.loaded.int.module.cmdmod][INFO    ][27637] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-25 03:44:37,393 [salt.loaded.int.module.cmdmod][INFO    ][27637] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-25 03:44:37,402 [salt.state       ][INFO    ][27637] The service glusterfs-server is already running
2017-09-25 03:44:37,402 [salt.state       ][INFO    ][27637] Completed state [glusterfs-server] at time 03:44:37.401807 duration_in_ms=28.512
2017-09-25 03:44:37,403 [salt.state       ][INFO    ][27637] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:44:37.403355
2017-09-25 03:44:37,404 [salt.state       ][INFO    ][27637] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-25 03:44:37,417 [salt.state       ][INFO    ][27637] File changed:
New file
2017-09-25 03:44:37,418 [salt.state       ][INFO    ][27637] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:44:37.417492 duration_in_ms=14.137
2017-09-25 03:44:37,418 [salt.state       ][INFO    ][27637] Running state [/srv/glusterfs/glance] at time 03:44:37.417681
2017-09-25 03:44:37,418 [salt.state       ][INFO    ][27637] Executing state file.directory for /srv/glusterfs/glance
2017-09-25 03:44:37,418 [salt.state       ][INFO    ][27637] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-25 03:44:37,419 [salt.state       ][INFO    ][27637] Completed state [/srv/glusterfs/glance] at time 03:44:37.418540 duration_in_ms=0.859
2017-09-25 03:44:37,419 [salt.state       ][INFO    ][27637] Running state [/srv/glusterfs/keystone-keys] at time 03:44:37.418697
2017-09-25 03:44:37,419 [salt.state       ][INFO    ][27637] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-25 03:44:37,419 [salt.state       ][INFO    ][27637] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-25 03:44:37,419 [salt.state       ][INFO    ][27637] Completed state [/srv/glusterfs/keystone-keys] at time 03:44:37.419336 duration_in_ms=0.639
2017-09-25 03:44:37,420 [salt.state       ][INFO    ][27637] Running state [/srv/glusterfs/nova_instances] at time 03:44:37.419484
2017-09-25 03:44:37,420 [salt.state       ][INFO    ][27637] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-25 03:44:37,420 [salt.state       ][INFO    ][27637] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-25 03:44:37,420 [salt.state       ][INFO    ][27637] Completed state [/srv/glusterfs/nova_instances] at time 03:44:37.420136 duration_in_ms=0.652
2017-09-25 03:44:37,420 [salt.state       ][INFO    ][27637] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:44:37.420285
2017-09-25 03:44:37,420 [salt.state       ][INFO    ][27637] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-25 03:44:37,421 [salt.state       ][INFO    ][27637] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-25 03:44:37,421 [salt.state       ][INFO    ][27637] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:44:37.420913 duration_in_ms=0.629
2017-09-25 03:44:37,422 [salt.minion      ][INFO    ][27637] Returning information for job: 20170925034409153556
2017-09-25 03:44:45,478 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command test.ping with jid 20170925034445465654
2017-09-25 03:44:45,531 [salt.minion      ][INFO    ][32347] Starting a new job with PID 32347
2017-09-25 03:44:45,564 [salt.minion      ][INFO    ][32347] Returning information for job: 20170925034445465654
2017-09-25 03:45:26,563 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command state.sls with jid 20170925034526550368
2017-09-25 03:45:26,580 [salt.minion      ][INFO    ][32562] Starting a new job with PID 32562
2017-09-25 03:45:28,023 [salt.state       ][INFO    ][32562] Loading fresh modules for state activity
2017-09-25 03:45:28,046 [salt.fileclient  ][INFO    ][32562] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-25 03:45:28,079 [salt.fileclient  ][INFO    ][32562] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-25 03:45:28,142 [salt.fileclient  ][INFO    ][32562] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-25 03:45:28,161 [salt.fileclient  ][INFO    ][32562] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-25 03:45:28,422 [salt.state       ][INFO    ][32562] Running state [attr] at time 03:45:28.421588
2017-09-25 03:45:28,422 [salt.state       ][INFO    ][32562] Executing state pkg.installed for attr
2017-09-25 03:45:28,422 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 03:45:28,689 [salt.state       ][INFO    ][32562] Package attr is already installed
2017-09-25 03:45:28,690 [salt.state       ][INFO    ][32562] Completed state [attr] at time 03:45:28.689621 duration_in_ms=268.034
2017-09-25 03:45:28,690 [salt.state       ][INFO    ][32562] Running state [glusterfs-server] at time 03:45:28.689837
2017-09-25 03:45:28,690 [salt.state       ][INFO    ][32562] Executing state pkg.installed for glusterfs-server
2017-09-25 03:45:28,693 [salt.state       ][INFO    ][32562] Package glusterfs-server is already installed
2017-09-25 03:45:28,693 [salt.state       ][INFO    ][32562] Completed state [glusterfs-server] at time 03:45:28.692695 duration_in_ms=2.857
2017-09-25 03:45:28,693 [salt.state       ][INFO    ][32562] Running state [bc] at time 03:45:28.692832
2017-09-25 03:45:28,693 [salt.state       ][INFO    ][32562] Executing state pkg.installed for bc
2017-09-25 03:45:28,695 [salt.state       ][INFO    ][32562] Package bc is already installed
2017-09-25 03:45:28,696 [salt.state       ][INFO    ][32562] Completed state [bc] at time 03:45:28.695568 duration_in_ms=2.735
2017-09-25 03:45:28,696 [salt.state       ][INFO    ][32562] Running state [glusterfs-server] at time 03:45:28.696348
2017-09-25 03:45:28,697 [salt.state       ][INFO    ][32562] Executing state service.running for glusterfs-server
2017-09-25 03:45:28,697 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-25 03:45:28,708 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-25 03:45:28,754 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-25 03:45:28,768 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-25 03:45:28,776 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-25 03:45:28,786 [salt.state       ][INFO    ][32562] The service glusterfs-server is already running
2017-09-25 03:45:28,786 [salt.state       ][INFO    ][32562] Completed state [glusterfs-server] at time 03:45:28.785815 duration_in_ms=89.465
2017-09-25 03:45:28,787 [salt.state       ][INFO    ][32562] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:45:28.787256
2017-09-25 03:45:28,787 [salt.state       ][INFO    ][32562] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-25 03:45:28,799 [salt.state       ][INFO    ][32562] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-25 03:45:28,799 [salt.state       ][INFO    ][32562] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:45:28.798890 duration_in_ms=11.634
2017-09-25 03:45:28,799 [salt.state       ][INFO    ][32562] Running state [/srv/glusterfs/glance] at time 03:45:28.799057
2017-09-25 03:45:28,799 [salt.state       ][INFO    ][32562] Executing state file.directory for /srv/glusterfs/glance
2017-09-25 03:45:28,800 [salt.state       ][INFO    ][32562] Directory /srv/glusterfs/glance is in the correct state
2017-09-25 03:45:28,800 [salt.state       ][INFO    ][32562] Completed state [/srv/glusterfs/glance] at time 03:45:28.799749 duration_in_ms=0.692
2017-09-25 03:45:28,800 [salt.state       ][INFO    ][32562] Running state [/srv/glusterfs/keystone-keys] at time 03:45:28.799903
2017-09-25 03:45:28,800 [salt.state       ][INFO    ][32562] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-25 03:45:28,800 [salt.state       ][INFO    ][32562] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-25 03:45:28,801 [salt.state       ][INFO    ][32562] Completed state [/srv/glusterfs/keystone-keys] at time 03:45:28.800500 duration_in_ms=0.597
2017-09-25 03:45:28,801 [salt.state       ][INFO    ][32562] Running state [/srv/glusterfs/nova_instances] at time 03:45:28.800652
2017-09-25 03:45:28,801 [salt.state       ][INFO    ][32562] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-25 03:45:28,801 [salt.state       ][INFO    ][32562] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-25 03:45:28,801 [salt.state       ][INFO    ][32562] Completed state [/srv/glusterfs/nova_instances] at time 03:45:28.801264 duration_in_ms=0.613
2017-09-25 03:45:28,801 [salt.state       ][INFO    ][32562] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:45:28.801416
2017-09-25 03:45:28,802 [salt.state       ][INFO    ][32562] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-25 03:45:28,802 [salt.state       ][INFO    ][32562] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-25 03:45:28,802 [salt.state       ][INFO    ][32562] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:45:28.802033 duration_in_ms=0.617
2017-09-25 03:45:28,854 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command ['git', '--version'] in directory '/root'
2017-09-25 03:45:28,931 [salt.state       ][INFO    ][32562] Running state [sleep 5] at time 03:45:28.931109
2017-09-25 03:45:28,931 [salt.state       ][INFO    ][32562] Executing state cmd.wait for sleep 5
2017-09-25 03:45:28,932 [salt.state       ][INFO    ][32562] No changes made for sleep 5
2017-09-25 03:45:28,932 [salt.state       ][INFO    ][32562] Completed state [sleep 5] at time 03:45:28.931699 duration_in_ms=0.59
2017-09-25 03:45:28,932 [salt.state       ][INFO    ][32562] Running state [10.167.4.141] at time 03:45:28.932092
2017-09-25 03:45:28,932 [salt.state       ][INFO    ][32562] Executing state glusterfs.peered for 10.167.4.141
2017-09-25 03:45:28,933 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:28,942 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:28,992 [salt.state       ][INFO    ][32562] Host 10.167.4.141 already peered
2017-09-25 03:45:28,992 [salt.state       ][INFO    ][32562] Completed state [10.167.4.141] at time 03:45:28.992194 duration_in_ms=60.101
2017-09-25 03:45:28,994 [salt.state       ][INFO    ][32562] Running state [10.167.4.142] at time 03:45:28.994413
2017-09-25 03:45:28,995 [salt.state       ][INFO    ][32562] Executing state glusterfs.peered for 10.167.4.142
2017-09-25 03:45:28,995 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:29,004 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:29,054 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:29,062 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:29,115 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:29,123 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:29,192 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:29,201 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:29,248 [salt.state       ][INFO    ][32562] {'new': {'kvm02.baremetal-mcp-ocata-odl-ha.local': ['10.167.4.142'], '10.167.4.141': []}, 'old': {'kvm02.baremetal-mcp-ocata-odl-ha.local': [], '10.167.4.141': []}}
2017-09-25 03:45:29,249 [salt.state       ][INFO    ][32562] Completed state [10.167.4.142] at time 03:45:29.248474 duration_in_ms=254.061
2017-09-25 03:45:29,251 [salt.state       ][INFO    ][32562] Running state [10.167.4.143] at time 03:45:29.250734
2017-09-25 03:45:29,251 [salt.state       ][INFO    ][32562] Executing state glusterfs.peered for 10.167.4.143
2017-09-25 03:45:29,251 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:29,260 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:29,308 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:29,316 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:29,366 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:29,375 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:29,425 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:29,435 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:29,489 [salt.state       ][INFO    ][32562] Peering with localhost is not needed
2017-09-25 03:45:29,489 [salt.state       ][INFO    ][32562] Completed state [10.167.4.143] at time 03:45:29.489214 duration_in_ms=238.479
2017-09-25 03:45:29,490 [salt.state       ][INFO    ][32562] Running state [glance] at time 03:45:29.489960
2017-09-25 03:45:29,490 [salt.state       ][INFO    ][32562] Executing state glusterfs.created for glance
2017-09-25 03:45:29,491 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:29,499 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:29,550 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:29,558 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:29,611 [salt.state       ][INFO    ][32562] Volume glance already exists and is started.
2017-09-25 03:45:29,611 [salt.state       ][INFO    ][32562] Completed state [glance] at time 03:45:29.611435 duration_in_ms=121.474
2017-09-25 03:45:29,614 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:29.614028
2017-09-25 03:45:29,614 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-25 03:45:29,615 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:29,662 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:29,662 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:29.662155 duration_in_ms=48.126
2017-09-25 03:45:29,663 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:45:29.662658
2017-09-25 03:45:29,663 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-25 03:45:29,663 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-25 03:45:29,715 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:29,716 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:45:29.715635 duration_in_ms=52.977
2017-09-25 03:45:29,716 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:45:29.716124
2017-09-25 03:45:29,716 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-25 03:45:29,717 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-25 03:45:29,766 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:29,766 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:45:29.766193 duration_in_ms=50.068
2017-09-25 03:45:29,767 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:29.766605
2017-09-25 03:45:29,767 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-25 03:45:29,767 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:29,817 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:29,817 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:29.816922 duration_in_ms=50.316
2017-09-25 03:45:29,817 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:45:29.817383
2017-09-25 03:45:29,818 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-25 03:45:29,818 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-25 03:45:29,867 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:29,868 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:45:29.867664 duration_in_ms=50.28
2017-09-25 03:45:29,869 [salt.state       ][INFO    ][32562] Running state [glance] at time 03:45:29.868571
2017-09-25 03:45:29,869 [salt.state       ][INFO    ][32562] Executing state glusterfs.started for glance
2017-09-25 03:45:29,869 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:29,878 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:29,927 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:29,935 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:29,989 [salt.state       ][INFO    ][32562] Volume glance is already started
2017-09-25 03:45:29,990 [salt.state       ][INFO    ][32562] Completed state [glance] at time 03:45:29.989546 duration_in_ms=120.974
2017-09-25 03:45:29,990 [salt.state       ][INFO    ][32562] Running state [keystone-keys] at time 03:45:29.990457
2017-09-25 03:45:29,991 [salt.state       ][INFO    ][32562] Executing state glusterfs.created for keystone-keys
2017-09-25 03:45:29,991 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:30,001 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:30,050 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:30,059 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:30,112 [salt.state       ][INFO    ][32562] Volume keystone-keys already exists and is started.
2017-09-25 03:45:30,113 [salt.state       ][INFO    ][32562] Completed state [keystone-keys] at time 03:45:30.112598 duration_in_ms=122.141
2017-09-25 03:45:30,116 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:45:30.115748
2017-09-25 03:45:30,116 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-25 03:45:30,117 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-25 03:45:30,166 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:30,167 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:45:30.166643 duration_in_ms=50.895
2017-09-25 03:45:30,167 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:30.167056
2017-09-25 03:45:30,167 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-25 03:45:30,168 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:30,217 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:30,217 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:30.217251 duration_in_ms=50.195
2017-09-25 03:45:30,218 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:30.217689
2017-09-25 03:45:30,218 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-25 03:45:30,218 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:30,271 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:30,271 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:30.271290 duration_in_ms=53.601
2017-09-25 03:45:30,272 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:45:30.271724
2017-09-25 03:45:30,272 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-25 03:45:30,272 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-25 03:45:30,322 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:30,322 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:45:30.321824 duration_in_ms=50.099
2017-09-25 03:45:30,322 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:45:30.322332
2017-09-25 03:45:30,323 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-25 03:45:30,323 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-25 03:45:30,370 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:30,371 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:45:30.370668 duration_in_ms=48.334
2017-09-25 03:45:30,372 [salt.state       ][INFO    ][32562] Running state [keystone-keys] at time 03:45:30.371638
2017-09-25 03:45:30,372 [salt.state       ][INFO    ][32562] Executing state glusterfs.started for keystone-keys
2017-09-25 03:45:30,372 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:30,381 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:30,430 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:30,439 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:30,494 [salt.state       ][INFO    ][32562] Volume keystone-keys is already started
2017-09-25 03:45:30,494 [salt.state       ][INFO    ][32562] Completed state [keystone-keys] at time 03:45:30.493749 duration_in_ms=122.111
2017-09-25 03:45:30,495 [salt.state       ][INFO    ][32562] Running state [nova_instances] at time 03:45:30.494669
2017-09-25 03:45:30,495 [salt.state       ][INFO    ][32562] Executing state glusterfs.created for nova_instances
2017-09-25 03:45:30,495 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:30,506 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:30,560 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:30,569 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:30,622 [salt.state       ][INFO    ][32562] Volume nova_instances already exists and is started.
2017-09-25 03:45:30,622 [salt.state       ][INFO    ][32562] Completed state [nova_instances] at time 03:45:30.622442 duration_in_ms=127.773
2017-09-25 03:45:30,625 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:30.625365
2017-09-25 03:45:30,626 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-25 03:45:30,626 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:30,677 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:30,678 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:30.677560 duration_in_ms=52.194
2017-09-25 03:45:30,678 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 03:45:30.677971
2017-09-25 03:45:30,678 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-09-25 03:45:30,679 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-25 03:45:30,728 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:30,729 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 03:45:30.728647 duration_in_ms=50.675
2017-09-25 03:45:30,729 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 03:45:30.729175
2017-09-25 03:45:30,729 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-09-25 03:45:30,730 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-25 03:45:30,780 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:30,781 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 03:45:30.780552 duration_in_ms=51.377
2017-09-25 03:45:30,781 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 03:45:30.780958
2017-09-25 03:45:30,781 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-09-25 03:45:30,782 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-09-25 03:45:30,830 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:30,831 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 03:45:30.830705 duration_in_ms=49.746
2017-09-25 03:45:30,831 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:30.831206
2017-09-25 03:45:30,831 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-25 03:45:30,832 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:30,885 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:30,885 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:30.884989 duration_in_ms=53.782
2017-09-25 03:45:30,886 [salt.state       ][INFO    ][32562] Running state [nova_instances] at time 03:45:30.885972
2017-09-25 03:45:30,886 [salt.state       ][INFO    ][32562] Executing state glusterfs.started for nova_instances
2017-09-25 03:45:30,887 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:30,896 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:30,944 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:30,953 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:31,006 [salt.state       ][INFO    ][32562] Volume nova_instances is already started
2017-09-25 03:45:31,007 [salt.state       ][INFO    ][32562] Completed state [nova_instances] at time 03:45:31.006489 duration_in_ms=120.517
2017-09-25 03:45:31,007 [salt.state       ][INFO    ][32562] Running state [keystone-credential-keys] at time 03:45:31.007368
2017-09-25 03:45:31,008 [salt.state       ][INFO    ][32562] Executing state glusterfs.created for keystone-credential-keys
2017-09-25 03:45:31,008 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:31,017 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:31,066 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:31,075 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:31,130 [salt.state       ][INFO    ][32562] Volume keystone-credential-keys already exists and is started.
2017-09-25 03:45:31,130 [salt.state       ][INFO    ][32562] Completed state [keystone-credential-keys] at time 03:45:31.130394 duration_in_ms=123.024
2017-09-25 03:45:31,134 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:45:31.133560
2017-09-25 03:45:31,134 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-25 03:45:31,134 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-25 03:45:31,188 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:31,188 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:45:31.188276 duration_in_ms=54.716
2017-09-25 03:45:31,189 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:31.188706
2017-09-25 03:45:31,189 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-25 03:45:31,191 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:31,241 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:31,242 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:45:31.241603 duration_in_ms=52.896
2017-09-25 03:45:31,243 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:45:31.242783
2017-09-25 03:45:31,243 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-25 03:45:31,244 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-25 03:45:31,298 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:31,298 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:45:31.298378 duration_in_ms=55.594
2017-09-25 03:45:31,299 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:31.298822
2017-09-25 03:45:31,299 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-25 03:45:31,299 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-25 03:45:31,352 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:31,353 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:45:31.352617 duration_in_ms=53.794
2017-09-25 03:45:31,353 [salt.state       ][INFO    ][32562] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:45:31.353035
2017-09-25 03:45:31,353 [salt.state       ][INFO    ][32562] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-25 03:45:31,354 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-25 03:45:31,402 [salt.state       ][INFO    ][32562] unless execution succeeded
2017-09-25 03:45:31,402 [salt.state       ][INFO    ][32562] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:45:31.402275 duration_in_ms=49.24
2017-09-25 03:45:31,403 [salt.state       ][INFO    ][32562] Running state [keystone-credential-keys] at time 03:45:31.403286
2017-09-25 03:45:31,404 [salt.state       ][INFO    ][32562] Executing state glusterfs.started for keystone-credential-keys
2017-09-25 03:45:31,404 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:31,413 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:31,462 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --version' in directory '/root'
2017-09-25 03:45:31,471 [salt.loaded.int.module.cmdmod][INFO    ][32562] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 03:45:31,531 [salt.state       ][INFO    ][32562] Volume keystone-credential-keys is already started
2017-09-25 03:45:31,531 [salt.state       ][INFO    ][32562] Completed state [keystone-credential-keys] at time 03:45:31.531373 duration_in_ms=128.087
2017-09-25 03:45:31,533 [salt.minion      ][INFO    ][32562] Returning information for job: 20170925034526550368
2017-09-25 03:45:39,845 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command test.ping with jid 20170925034539833722
2017-09-25 03:45:39,861 [salt.minion      ][INFO    ][522] Starting a new job with PID 522
2017-09-25 03:45:39,887 [salt.minion      ][INFO    ][522] Returning information for job: 20170925034539833722
2017-09-25 03:45:40,303 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command cmd.run with jid 20170925034540290643
2017-09-25 03:45:40,318 [salt.minion      ][INFO    ][528] Starting a new job with PID 528
2017-09-25 03:45:40,322 [salt.loaded.int.module.cmdmod][INFO    ][528] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-25 03:45:40,434 [salt.minion      ][INFO    ][528] Returning information for job: 20170925034540290643
2017-09-25 04:05:37,321 [salt.utils.schedule][INFO    ][23991] Running scheduled job: __mine_interval
2017-09-25 05:01:10,872 [salt.minion      ][INFO    ][23991] User sudo_ubuntu Executing command cp.push_dir with jid 20170925050110860852
2017-09-25 05:01:10,889 [salt.minion      ][INFO    ][1723] Starting a new job with PID 1723
