2017-09-14 20:47:10,722 [salt.cli.daemons ][WARNING ][2554] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-14 20:47:13,206 [salt.loaded.int.module.cmdmod][ERROR   ][2884] Command '['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bridge-utils']' failed with return code: 100
2017-09-14 20:47:13,206 [salt.loaded.int.module.cmdmod][ERROR   ][2884] stderr: Running scope as unit run-r77f3679aac2c42108b735dad7cc6b9fd.scope.
E: Could not get lock /var/lib/dpkg/lock - open (11: Resource temporarily unavailable)
E: Unable to lock the administration directory (/var/lib/dpkg/), is another process using it?
2017-09-14 20:47:13,206 [salt.loaded.int.module.cmdmod][ERROR   ][2884] retcode: 100
2017-09-14 20:47:13,313 [salt.minion      ][ERROR   ][2884] A command in 'pkg.install' had a problem: Problem encountered installing package(s). Additional info follows:

changes:
    ----------
errors:
    - Running scope as unit run-r77f3679aac2c42108b735dad7cc6b9fd.scope.
      E: Could not get lock /var/lib/dpkg/lock - open (11: Resource temporarily unavailable)
      E: Unable to lock the administration directory (/var/lib/dpkg/), is another process using it?
2017-09-14 20:47:26,868 [salt.utils.parsers][WARNING ][2554] Minion received a SIGTERM. Exiting.
2017-09-14 20:49:50,738 [salt.cli.daemons ][WARNING ][3327] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-14 20:50:48,277 [salt.transport.ipc][ERROR   ][3327] Exception occurred while handling stream: [Errno 0] Success
2017-09-14 20:53:10,080 [py.warnings      ][WARNING ][16330] /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-14 20:54:02,307 [salt.state       ][ERROR   ][16330] Module function virtng.init is not available
2017-09-14 20:54:02,353 [salt.state       ][ERROR   ][16330] Module function virt.set_autostart threw an exception. Exception: No virtual machines found.
2017-09-14 20:54:02,400 [salt.state       ][ERROR   ][16330] Module function virtng.init is not available
2017-09-14 20:54:02,443 [salt.state       ][ERROR   ][16330] Module function virt.set_autostart threw an exception. Exception: No virtual machines found.
2017-09-14 20:54:02,488 [salt.state       ][ERROR   ][16330] Module function virtng.init is not available
2017-09-14 20:54:02,530 [salt.state       ][ERROR   ][16330] Module function virt.set_autostart threw an exception. Exception: No virtual machines found.
2017-09-14 20:54:02,577 [salt.state       ][ERROR   ][16330] Module function virtng.init is not available
2017-09-14 20:54:02,623 [salt.state       ][ERROR   ][16330] Module function virt.set_autostart threw an exception. Exception: No virtual machines found.
2017-09-14 20:54:02,671 [salt.state       ][ERROR   ][16330] Module function virtng.init is not available
2017-09-14 20:54:02,714 [salt.state       ][ERROR   ][16330] Module function virt.set_autostart threw an exception. Exception: No virtual machines found.
2017-09-14 20:54:02,729 [salt.loaded.int.module.cmdmod][ERROR   ][16330] 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-14 20:54:05,034 [salt.loaded.int.module.cmdmod][INFO    ][22490] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-14 20:54:05,049 [salt.loaded.int.module.cmdmod][INFO    ][22490] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-14 20:54:05,072 [salt.loaded.int.module.cmdmod][INFO    ][22490] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-14 20:54:05,091 [salt.utils.parsers][WARNING ][3327] Minion received a SIGTERM. Exiting.
2017-09-14 20:54:05,517 [salt.cli.daemons ][INFO    ][22567] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-odl-ha.local"
2017-09-14 20:54:05,1000 [salt.minion      ][INFO    ][22567] Creating minion process manager
2017-09-14 20:54:06,000 [salt.cli.daemons ][WARNING ][22567] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-14 20:54:06,010 [salt.cli.daemons ][INFO    ][22567] The Salt Minion is starting up
2017-09-14 20:54:06,010 [salt.minion      ][INFO    ][22567] Minion is starting as user 'root'
2017-09-14 20:54:06,011 [salt.utils.event ][INFO    ][22567] Starting pull socket on /var/run/salt/minion/minion_event_127643860a_pull.ipc
2017-09-14 20:54:06,838 [salt.loaded.int.module.cmdmod][INFO    ][22567] Executing command ['date', '+%z'] in directory '/root'
2017-09-14 20:54:06,856 [salt.utils.schedule][INFO    ][22567] Updating job settings for scheduled job: __mine_interval
2017-09-14 20:54:06,862 [salt.minion      ][INFO    ][22567] Added mine.update to scheduler
2017-09-14 20:54:06,895 [salt.minion      ][INFO    ][22567] Minion is ready to receive requests!
2017-09-14 20:54:07,896 [salt.utils.schedule][INFO    ][22567] Running scheduled job: __mine_interval
2017-09-14 21:03:53,970 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170914210353964370
2017-09-14 21:03:53,995 [salt.minion      ][INFO    ][22677] Starting a new job with PID 22677
2017-09-14 21:03:55,531 [salt.state       ][INFO    ][22677] Loading fresh modules for state activity
2017-09-14 21:03:55,571 [salt.state       ][ERROR   ][22677] No contents found in top file
2017-09-14 21:03:55,572 [salt.utils.extmods][INFO    ][22677] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-14 21:03:55,578 [salt.utils.extmods][INFO    ][22677] Syncing beacons for environment 'base'
2017-09-14 21:03:55,579 [salt.utils.extmods][INFO    ][22677] Loading cache from salt://_beacons, for base)
2017-09-14 21:03:55,579 [salt.fileclient  ][INFO    ][22677] Caching directory '_beacons/' for environment 'base'
2017-09-14 21:03:55,612 [salt.utils.extmods][INFO    ][22677] Creating module dir '/var/cache/salt/minion/extmods/modules'
2017-09-14 21:03:55,617 [salt.utils.extmods][INFO    ][22677] Syncing modules for environment 'base'
2017-09-14 21:03:55,618 [salt.utils.extmods][INFO    ][22677] Loading cache from salt://_modules, for base)
2017-09-14 21:03:55,618 [salt.fileclient  ][INFO    ][22677] Caching directory '_modules/' for environment 'base'
2017-09-14 21:03:55,670 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-14 21:03:55,682 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-14 21:03:55,698 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-14 21:03:55,710 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-14 21:03:55,722 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-14 21:03:55,736 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-14 21:03:55,750 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-14 21:03:55,764 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-14 21:03:55,778 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-14 21:03:55,792 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-14 21:03:55,805 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-14 21:03:55,818 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-14 21:03:55,831 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-14 21:03:55,845 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-14 21:03:55,858 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-14 21:03:55,872 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-14 21:03:55,886 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-14 21:03:55,899 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-14 21:03:55,912 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-14 21:03:55,927 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-14 21:03:55,944 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-14 21:03:55,958 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-14 21:03:55,973 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-14 21:03:55,987 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-14 21:03:56,001 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-14 21:03:56,015 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-14 21:03:56,029 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-14 21:03:56,052 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-14 21:03:56,065 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-14 21:03:56,081 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-14 21:03:56,094 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-14 21:03:56,110 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-14 21:03:56,117 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-14 21:03:56,117 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-14 21:03:56,118 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-14 21:03:56,118 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-14 21:03:56,119 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-14 21:03:56,119 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-14 21:03:56,120 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-14 21:03:56,120 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-14 21:03:56,121 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-14 21:03:56,121 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-14 21:03:56,122 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-14 21:03:56,122 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-14 21:03:56,123 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-14 21:03:56,123 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-14 21:03:56,124 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-14 21:03:56,124 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-14 21:03:56,125 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-14 21:03:56,125 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-14 21:03:56,126 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-14 21:03:56,126 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-14 21:03:56,127 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-14 21:03:56,127 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-14 21:03:56,128 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-14 21:03:56,128 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-14 21:03:56,129 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-14 21:03:56,129 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-14 21:03:56,130 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-14 21:03:56,130 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-14 21:03:56,130 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-14 21:03:56,131 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-14 21:03:56,131 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-14 21:03:56,132 [salt.utils.extmods][INFO    ][22677] 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-14 21:03:56,132 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-14 21:03:56,133 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-14 21:03:56,135 [salt.utils.extmods][INFO    ][22677] Creating module dir '/var/cache/salt/minion/extmods/states'
2017-09-14 21:03:56,140 [salt.utils.extmods][INFO    ][22677] Syncing states for environment 'base'
2017-09-14 21:03:56,140 [salt.utils.extmods][INFO    ][22677] Loading cache from salt://_states, for base)
2017-09-14 21:03:56,140 [salt.fileclient  ][INFO    ][22677] Caching directory '_states/' for environment 'base'
2017-09-14 21:03:56,186 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-14 21:03:56,200 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-14 21:03:56,212 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-14 21:03:56,225 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-14 21:03:56,237 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-14 21:03:56,250 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-14 21:03:56,262 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-14 21:03:56,274 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-14 21:03:56,286 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-14 21:03:56,298 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-14 21:03:56,309 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-14 21:03:56,321 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-14 21:03:56,333 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-14 21:03:56,344 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-14 21:03:56,356 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-14 21:03:56,367 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-14 21:03:56,378 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-14 21:03:56,389 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-14 21:03:56,400 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-14 21:03:56,411 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-14 21:03:56,424 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-14 21:03:56,434 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-14 21:03:56,446 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-14 21:03:56,466 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-14 21:03:56,477 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-14 21:03:56,488 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-14 21:03:56,498 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-14 21:03:56,509 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-14 21:03:56,519 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-14 21:03:56,525 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-14 21:03:56,525 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-14 21:03:56,526 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-14 21:03:56,526 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-14 21:03:56,527 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-14 21:03:56,527 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-14 21:03:56,527 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-14 21:03:56,528 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-14 21:03:56,528 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-14 21:03:56,529 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-14 21:03:56,529 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-14 21:03:56,530 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-14 21:03:56,530 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-14 21:03:56,530 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-14 21:03:56,531 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-14 21:03:56,531 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-14 21:03:56,532 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-14 21:03:56,532 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-14 21:03:56,533 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-14 21:03:56,533 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-14 21:03:56,533 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-14 21:03:56,534 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-14 21:03:56,534 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-14 21:03:56,535 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-14 21:03:56,535 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-14 21:03:56,535 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-14 21:03:56,536 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-14 21:03:56,536 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-14 21:03:56,537 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-14 21:03:56,537 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-14 21:03:56,539 [salt.utils.extmods][INFO    ][22677] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-14 21:03:56,545 [salt.utils.extmods][INFO    ][22677] Syncing sdb for environment 'base'
2017-09-14 21:03:56,545 [salt.utils.extmods][INFO    ][22677] Loading cache from salt://_sdb, for base)
2017-09-14 21:03:56,546 [salt.fileclient  ][INFO    ][22677] Caching directory '_sdb/' for environment 'base'
2017-09-14 21:03:56,577 [salt.utils.extmods][INFO    ][22677] Creating module dir '/var/cache/salt/minion/extmods/grains'
2017-09-14 21:03:56,582 [salt.utils.extmods][INFO    ][22677] Syncing grains for environment 'base'
2017-09-14 21:03:56,582 [salt.utils.extmods][INFO    ][22677] Loading cache from salt://_grains, for base)
2017-09-14 21:03:56,582 [salt.fileclient  ][INFO    ][22677] Caching directory '_grains/' for environment 'base'
2017-09-14 21:03:56,619 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-14 21:03:56,629 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-14 21:03:56,639 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-14 21:03:56,650 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-14 21:03:56,659 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-14 21:03:56,669 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-14 21:03:56,679 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-14 21:03:56,689 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-14 21:03:56,699 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-14 21:03:56,708 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-14 21:03:56,718 [salt.fileclient  ][INFO    ][22677] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-14 21:03:56,724 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-14 21:03:56,725 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-14 21:03:56,725 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-14 21:03:56,725 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-14 21:03:56,726 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-14 21:03:56,726 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-14 21:03:56,727 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-14 21:03:56,727 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-14 21:03:56,728 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-14 21:03:56,728 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-14 21:03:56,729 [salt.utils.extmods][INFO    ][22677] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-14 21:03:56,730 [salt.utils.extmods][INFO    ][22677] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-14 21:03:56,734 [salt.utils.extmods][INFO    ][22677] Syncing renderers for environment 'base'
2017-09-14 21:03:56,735 [salt.utils.extmods][INFO    ][22677] Loading cache from salt://_renderers, for base)
2017-09-14 21:03:56,735 [salt.fileclient  ][INFO    ][22677] Caching directory '_renderers/' for environment 'base'
2017-09-14 21:03:56,762 [salt.utils.extmods][INFO    ][22677] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-14 21:03:56,766 [salt.utils.extmods][INFO    ][22677] Syncing returners for environment 'base'
2017-09-14 21:03:56,766 [salt.utils.extmods][INFO    ][22677] Loading cache from salt://_returners, for base)
2017-09-14 21:03:56,767 [salt.fileclient  ][INFO    ][22677] Caching directory '_returners/' for environment 'base'
2017-09-14 21:03:56,800 [salt.utils.extmods][INFO    ][22677] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-14 21:03:56,806 [salt.utils.extmods][INFO    ][22677] Syncing output for environment 'base'
2017-09-14 21:03:56,806 [salt.utils.extmods][INFO    ][22677] Loading cache from salt://_output, for base)
2017-09-14 21:03:56,806 [salt.fileclient  ][INFO    ][22677] Caching directory '_output/' for environment 'base'
2017-09-14 21:03:56,837 [salt.utils.extmods][INFO    ][22677] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-14 21:03:56,842 [salt.utils.extmods][INFO    ][22677] Syncing utils for environment 'base'
2017-09-14 21:03:56,842 [salt.utils.extmods][INFO    ][22677] Loading cache from salt://_utils, for base)
2017-09-14 21:03:56,843 [salt.fileclient  ][INFO    ][22677] Caching directory '_utils/' for environment 'base'
2017-09-14 21:03:56,877 [salt.utils.extmods][INFO    ][22677] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-14 21:03:56,881 [salt.utils.extmods][INFO    ][22677] Syncing log_handlers for environment 'base'
2017-09-14 21:03:56,882 [salt.utils.extmods][INFO    ][22677] Loading cache from salt://_log_handlers, for base)
2017-09-14 21:03:56,882 [salt.fileclient  ][INFO    ][22677] Caching directory '_log_handlers/' for environment 'base'
2017-09-14 21:03:56,908 [salt.utils.extmods][INFO    ][22677] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-14 21:03:56,912 [salt.utils.extmods][INFO    ][22677] Syncing proxy for environment 'base'
2017-09-14 21:03:56,912 [salt.utils.extmods][INFO    ][22677] Loading cache from salt://_proxy, for base)
2017-09-14 21:03:56,912 [salt.fileclient  ][INFO    ][22677] Caching directory '_proxy/' for environment 'base'
2017-09-14 21:03:56,942 [salt.utils.extmods][INFO    ][22677] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-14 21:03:56,945 [salt.utils.extmods][INFO    ][22677] Syncing engines for environment 'base'
2017-09-14 21:03:56,946 [salt.utils.extmods][INFO    ][22677] Loading cache from salt://_engines, for base)
2017-09-14 21:03:56,946 [salt.fileclient  ][INFO    ][22677] Caching directory '_engines/' for environment 'base'
2017-09-14 21:03:56,973 [salt.minion      ][INFO    ][22677] Returning information for job: 20170914210353964370
2017-09-14 21:04:08,095 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command state.sls with jid 20170914210408091613
2017-09-14 21:04:08,116 [salt.minion      ][INFO    ][22773] Starting a new job with PID 22773
2017-09-14 21:04:08,616 [salt.state       ][INFO    ][22773] Loading fresh modules for state activity
2017-09-14 21:04:08,774 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-14 21:04:08,798 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-14 21:04:08,833 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-14 21:04:08,961 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-14 21:04:08,979 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-14 21:04:09,012 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-14 21:04:09,081 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-14 21:04:09,103 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:04:09,160 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-14 21:04:09,182 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-14 21:04:09,200 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-14 21:04:09,225 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-14 21:04:09,242 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-14 21:04:09,281 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-14 21:04:09,315 [py.warnings      ][WARNING ][22773] /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-14 21:04:09,316 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'salt-minion --version' in directory '/root'
2017-09-14 21:04:09,661 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-14 21:04:09,677 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-14 21:04:09,687 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-14 21:04:09,698 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-14 21:04:09,777 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-14 21:04:09,831 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-14 21:04:09,925 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-14 21:04:09,950 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-14 21:04:10,023 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-14 21:04:10,046 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:04:10,107 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-14 21:04:10,130 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-14 21:04:10,146 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-14 21:04:10,163 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-14 21:04:10,173 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-14 21:04:10,200 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-14 21:04:10,217 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'salt-minion --version' in directory '/root'
2017-09-14 21:04:10,589 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-14 21:04:10,613 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-14 21:04:10,628 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-14 21:04:10,644 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-14 21:04:10,717 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-14 21:04:10,766 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-14 21:04:10,863 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-14 21:04:10,935 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-14 21:04:11,285 [salt.state       ][INFO    ][22773] Running state [salt-minion] at time 21:04:11.284857
2017-09-14 21:04:11,285 [salt.state       ][INFO    ][22773] Executing state pkg.installed for salt-minion
2017-09-14 21:04:11,286 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:04:11,712 [salt.state       ][INFO    ][22773] Package salt-minion is already installed
2017-09-14 21:04:11,714 [salt.state       ][INFO    ][22773] Completed state [salt-minion] at time 21:04:11.713828 duration_in_ms=428.97
2017-09-14 21:04:11,715 [salt.state       ][INFO    ][22773] Running state [python-yaml] at time 21:04:11.714530
2017-09-14 21:04:11,715 [salt.state       ][INFO    ][22773] Executing state pkg.installed for python-yaml
2017-09-14 21:04:11,723 [salt.state       ][INFO    ][22773] Package python-yaml is already installed
2017-09-14 21:04:11,723 [salt.state       ][INFO    ][22773] Completed state [python-yaml] at time 21:04:11.723239 duration_in_ms=8.709
2017-09-14 21:04:11,724 [salt.state       ][INFO    ][22773] Running state [python-psutil] at time 21:04:11.723639
2017-09-14 21:04:11,724 [salt.state       ][INFO    ][22773] Executing state pkg.installed for python-psutil
2017-09-14 21:04:11,731 [salt.state       ][INFO    ][22773] Package python-psutil is already installed
2017-09-14 21:04:11,731 [salt.state       ][INFO    ][22773] Completed state [python-psutil] at time 21:04:11.731330 duration_in_ms=7.691
2017-09-14 21:04:11,732 [salt.state       ][INFO    ][22773] Running state [python-m2crypto] at time 21:04:11.731704
2017-09-14 21:04:11,732 [salt.state       ][INFO    ][22773] Executing state pkg.installed for python-m2crypto
2017-09-14 21:04:11,739 [salt.state       ][INFO    ][22773] Package python-m2crypto is already installed
2017-09-14 21:04:11,739 [salt.state       ][INFO    ][22773] Completed state [python-m2crypto] at time 21:04:11.739219 duration_in_ms=7.515
2017-09-14 21:04:11,743 [salt.state       ][INFO    ][22773] Running state [/etc/salt/minion.d/minion.conf] at time 21:04:11.742919
2017-09-14 21:04:11,743 [salt.state       ][INFO    ][22773] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-14 21:04:11,770 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-14 21:04:11,853 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-14 21:04:11,917 [salt.fileclient  ][INFO    ][22773] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:04:11,957 [salt.state       ][INFO    ][22773] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-14 21:04:11,957 [salt.state       ][INFO    ][22773] Completed state [/etc/salt/minion.d/minion.conf] at time 21:04:11.957212 duration_in_ms=214.294
2017-09-14 21:04:11,958 [salt.state       ][INFO    ][22773] Running state [/etc/salt/minion.d/_virt.conf] at time 21:04:11.957573
2017-09-14 21:04:11,958 [salt.state       ][INFO    ][22773] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-14 21:04:11,964 [salt.state       ][INFO    ][22773] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-14 21:04:11,965 [salt.state       ][INFO    ][22773] Completed state [/etc/salt/minion.d/_virt.conf] at time 21:04:11.964620 duration_in_ms=7.046
2017-09-14 21:04:11,966 [salt.state       ][INFO    ][22773] Running state [salt-minion] at time 21:04:11.965830
2017-09-14 21:04:11,966 [salt.state       ][INFO    ][22773] Executing state service.running for salt-minion
2017-09-14 21:04:11,966 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-14 21:04:11,997 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-14 21:04:12,014 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-14 21:04:12,030 [salt.state       ][INFO    ][22773] The service salt-minion is already running
2017-09-14 21:04:12,031 [salt.state       ][INFO    ][22773] Completed state [salt-minion] at time 21:04:12.030662 duration_in_ms=64.83
2017-09-14 21:04:12,034 [salt.state       ][INFO    ][22773] Running state [/etc/salt/grains.d] at time 21:04:12.033476
2017-09-14 21:04:12,034 [salt.state       ][INFO    ][22773] Executing state file.directory for /etc/salt/grains.d
2017-09-14 21:04:12,035 [salt.state       ][INFO    ][22773] Directory /etc/salt/grains.d is in the correct state
2017-09-14 21:04:12,036 [salt.state       ][INFO    ][22773] Completed state [/etc/salt/grains.d] at time 21:04:12.035805 duration_in_ms=2.329
2017-09-14 21:04:12,037 [salt.state       ][INFO    ][22773] Running state [/etc/salt/grains] at time 21:04:12.037171
2017-09-14 21:04:12,038 [salt.state       ][INFO    ][22773] Executing state file.managed for /etc/salt/grains
2017-09-14 21:04:12,039 [salt.state       ][INFO    ][22773] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-14 21:04:12,039 [salt.state       ][INFO    ][22773] Completed state [/etc/salt/grains] at time 21:04:12.039031 duration_in_ms=1.861
2017-09-14 21:04:12,040 [salt.state       ][INFO    ][22773] Running state [/etc/salt/grains.d/placeholder] at time 21:04:12.039794
2017-09-14 21:04:12,040 [salt.state       ][INFO    ][22773] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-14 21:04:12,041 [salt.state       ][INFO    ][22773] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-14 21:04:12,041 [salt.state       ][INFO    ][22773] Completed state [/etc/salt/grains.d/placeholder] at time 21:04:12.041345 duration_in_ms=1.551
2017-09-14 21:04:12,042 [salt.state       ][INFO    ][22773] Running state [/etc/salt/grains.d/sphinx] at time 21:04:12.042071
2017-09-14 21:04:12,043 [salt.state       ][INFO    ][22773] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-14 21:04:12,049 [salt.state       ][INFO    ][22773] File /etc/salt/grains.d/sphinx is in the correct state
2017-09-14 21:04:12,049 [salt.state       ][INFO    ][22773] Completed state [/etc/salt/grains.d/sphinx] at time 21:04:12.048911 duration_in_ms=6.84
2017-09-14 21:04:12,050 [salt.state       ][INFO    ][22773] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:04:12.050053
2017-09-14 21:04:12,050 [salt.state       ][INFO    ][22773] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-14 21:04:12,051 [salt.state       ][INFO    ][22773] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-14 21:04:12,051 [salt.state       ][INFO    ][22773] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:04:12.051239 duration_in_ms=1.186
2017-09-14 21:04:12,052 [salt.state       ][INFO    ][22773] Running state [/etc/salt/grains.d/dns_records] at time 21:04:12.051924
2017-09-14 21:04:12,052 [salt.state       ][INFO    ][22773] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-14 21:04:12,055 [salt.state       ][INFO    ][22773] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-14 21:04:12,055 [salt.state       ][INFO    ][22773] Completed state [/etc/salt/grains.d/dns_records] at time 21:04:12.054888 duration_in_ms=2.963
2017-09-14 21:04:12,056 [salt.state       ][INFO    ][22773] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:04:12.056052
2017-09-14 21:04:12,057 [salt.state       ][INFO    ][22773] 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-14 21:04:12,057 [salt.state       ][INFO    ][22773] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-14 21:04:12,057 [salt.state       ][INFO    ][22773] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:04:12.057287 duration_in_ms=1.235
2017-09-14 21:04:12,058 [salt.state       ][INFO    ][22773] Running state [/etc/salt/grains.d/salt] at time 21:04:12.057980
2017-09-14 21:04:12,058 [salt.state       ][INFO    ][22773] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-14 21:04:12,061 [salt.state       ][INFO    ][22773] File /etc/salt/grains.d/salt is in the correct state
2017-09-14 21:04:12,061 [salt.state       ][INFO    ][22773] Completed state [/etc/salt/grains.d/salt] at time 21:04:12.060849 duration_in_ms=2.868
2017-09-14 21:04:12,062 [salt.state       ][INFO    ][22773] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:04:12.061844
2017-09-14 21:04:12,062 [salt.state       ][INFO    ][22773] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-14 21:04:12,063 [salt.state       ][INFO    ][22773] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-14 21:04:12,063 [salt.state       ][INFO    ][22773] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:04:12.062939 duration_in_ms=1.095
2017-09-14 21:04:12,066 [salt.state       ][INFO    ][22773] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:04:12.065863
2017-09-14 21:04:12,066 [salt.state       ][INFO    ][22773] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-14 21:04:12,067 [salt.state       ][INFO    ][22773] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-14 21:04:12,067 [salt.state       ][INFO    ][22773] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:04:12.066999 duration_in_ms=1.136
2017-09-14 21:04:12,068 [salt.state       ][INFO    ][22773] Running state [mine.update] at time 21:04:12.067949
2017-09-14 21:04:12,068 [salt.state       ][INFO    ][22773] Executing state module.wait for mine.update
2017-09-14 21:04:12,069 [salt.state       ][INFO    ][22773] No changes made for mine.update
2017-09-14 21:04:12,069 [salt.state       ][INFO    ][22773] Completed state [mine.update] at time 21:04:12.068994 duration_in_ms=1.044
2017-09-14 21:04:12,069 [salt.state       ][INFO    ][22773] Running state [ca-certificates] at time 21:04:12.069319
2017-09-14 21:04:12,070 [salt.state       ][INFO    ][22773] Executing state pkg.installed for ca-certificates
2017-09-14 21:04:12,077 [salt.state       ][INFO    ][22773] Package ca-certificates is already installed
2017-09-14 21:04:12,077 [salt.state       ][INFO    ][22773] Completed state [ca-certificates] at time 21:04:12.076806 duration_in_ms=7.487
2017-09-14 21:04:12,078 [salt.state       ][INFO    ][22773] Running state [update-ca-certificates] at time 21:04:12.077745
2017-09-14 21:04:12,078 [salt.state       ][INFO    ][22773] Executing state cmd.wait for update-ca-certificates
2017-09-14 21:04:12,079 [salt.state       ][INFO    ][22773] No changes made for update-ca-certificates
2017-09-14 21:04:12,079 [salt.state       ][INFO    ][22773] Completed state [update-ca-certificates] at time 21:04:12.078763 duration_in_ms=1.018
2017-09-14 21:04:12,079 [salt.state       ][INFO    ][22773] Running state [libvirt-dev] at time 21:04:12.079078
2017-09-14 21:04:12,079 [salt.state       ][INFO    ][22773] Executing state pkg.installed for libvirt-dev
2017-09-14 21:04:12,085 [salt.state       ][INFO    ][22773] Package libvirt-dev is already installed
2017-09-14 21:04:12,086 [salt.state       ][INFO    ][22773] Completed state [libvirt-dev] at time 21:04:12.085707 duration_in_ms=6.628
2017-09-14 21:04:12,086 [salt.state       ][INFO    ][22773] Running state [pkg-config] at time 21:04:12.086007
2017-09-14 21:04:12,086 [salt.state       ][INFO    ][22773] Executing state pkg.installed for pkg-config
2017-09-14 21:04:12,092 [salt.state       ][INFO    ][22773] Package pkg-config is already installed
2017-09-14 21:04:12,092 [salt.state       ][INFO    ][22773] Completed state [pkg-config] at time 21:04:12.092272 duration_in_ms=6.266
2017-09-14 21:04:12,093 [salt.state       ][INFO    ][22773] Running state [virtng.init] at time 21:04:12.092579
2017-09-14 21:04:12,093 [salt.state       ][INFO    ][22773] Executing state module.run for virtng.init
2017-09-14 21:04:12,181 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command ['git', '--version'] in directory '/root'
2017-09-14 21:04:12,361 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-14 21:04:18,252 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210418226004
2017-09-14 21:04:18,312 [salt.minion      ][INFO    ][22828] Starting a new job with PID 22828
2017-09-14 21:04:18,331 [salt.minion      ][INFO    ][22828] Returning information for job: 20170914210418226004
2017-09-14 21:04:28,286 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210428276581
2017-09-14 21:04:28,308 [salt.minion      ][INFO    ][22846] Starting a new job with PID 22846
2017-09-14 21:04:28,328 [salt.minion      ][INFO    ][22846] Returning information for job: 20170914210428276581
2017-09-14 21:04:38,493 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210438482611
2017-09-14 21:04:38,516 [salt.minion      ][INFO    ][22851] Starting a new job with PID 22851
2017-09-14 21:04:38,535 [salt.minion      ][INFO    ][22851] Returning information for job: 20170914210438482611
2017-09-14 21:04:48,515 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210448505943
2017-09-14 21:04:48,539 [salt.minion      ][INFO    ][22856] Starting a new job with PID 22856
2017-09-14 21:04:48,556 [salt.minion      ][INFO    ][22856] Returning information for job: 20170914210448505943
2017-09-14 21:04:58,739 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210458730395
2017-09-14 21:04:58,763 [salt.minion      ][INFO    ][22861] Starting a new job with PID 22861
2017-09-14 21:04:58,781 [salt.minion      ][INFO    ][22861] Returning information for job: 20170914210458730395
2017-09-14 21:05:08,803 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210508783032
2017-09-14 21:05:08,826 [salt.minion      ][INFO    ][22866] Starting a new job with PID 22866
2017-09-14 21:05:08,843 [salt.minion      ][INFO    ][22866] Returning information for job: 20170914210508783032
2017-09-14 21:05:19,013 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210519002904
2017-09-14 21:05:19,035 [salt.minion      ][INFO    ][22871] Starting a new job with PID 22871
2017-09-14 21:05:19,054 [salt.minion      ][INFO    ][22871] Returning information for job: 20170914210519002904
2017-09-14 21:05:29,058 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210529048444
2017-09-14 21:05:29,080 [salt.minion      ][INFO    ][22876] Starting a new job with PID 22876
2017-09-14 21:05:29,098 [salt.minion      ][INFO    ][22876] Returning information for job: 20170914210529048444
2017-09-14 21:05:39,269 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210539258304
2017-09-14 21:05:39,290 [salt.minion      ][INFO    ][22881] Starting a new job with PID 22881
2017-09-14 21:05:39,308 [salt.minion      ][INFO    ][22881] Returning information for job: 20170914210539258304
2017-09-14 21:05:49,489 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210549478734
2017-09-14 21:05:49,511 [salt.minion      ][INFO    ][22886] Starting a new job with PID 22886
2017-09-14 21:05:49,528 [salt.minion      ][INFO    ][22886] Returning information for job: 20170914210549478734
2017-09-14 21:05:59,704 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210559693145
2017-09-14 21:05:59,726 [salt.minion      ][INFO    ][22891] Starting a new job with PID 22891
2017-09-14 21:05:59,744 [salt.minion      ][INFO    ][22891] Returning information for job: 20170914210559693145
2017-09-14 21:06:09,921 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210609911907
2017-09-14 21:06:09,943 [salt.minion      ][INFO    ][22896] Starting a new job with PID 22896
2017-09-14 21:06:09,961 [salt.minion      ][INFO    ][22896] Returning information for job: 20170914210609911907
2017-09-14 21:06:20,142 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210620132162
2017-09-14 21:06:20,163 [salt.minion      ][INFO    ][22901] Starting a new job with PID 22901
2017-09-14 21:06:20,180 [salt.minion      ][INFO    ][22901] Returning information for job: 20170914210620132162
2017-09-14 21:06:30,360 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210630349800
2017-09-14 21:06:30,382 [salt.minion      ][INFO    ][22906] Starting a new job with PID 22906
2017-09-14 21:06:30,400 [salt.minion      ][INFO    ][22906] Returning information for job: 20170914210630349800
2017-09-14 21:06:40,587 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210640577415
2017-09-14 21:06:40,609 [salt.minion      ][INFO    ][22911] Starting a new job with PID 22911
2017-09-14 21:06:40,626 [salt.minion      ][INFO    ][22911] Returning information for job: 20170914210640577415
2017-09-14 21:06:50,608 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210650598332
2017-09-14 21:06:50,631 [salt.minion      ][INFO    ][22926] Starting a new job with PID 22926
2017-09-14 21:06:50,648 [salt.minion      ][INFO    ][22926] Returning information for job: 20170914210650598332
2017-09-14 21:07:00,837 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210700826080
2017-09-14 21:07:00,858 [salt.minion      ][INFO    ][22931] Starting a new job with PID 22931
2017-09-14 21:07:00,876 [salt.minion      ][INFO    ][22931] Returning information for job: 20170914210700826080
2017-09-14 21:07:10,857 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210710847244
2017-09-14 21:07:10,879 [salt.minion      ][INFO    ][22936] Starting a new job with PID 22936
2017-09-14 21:07:10,896 [salt.minion      ][INFO    ][22936] Returning information for job: 20170914210710847244
2017-09-14 21:07:20,901 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210720868360
2017-09-14 21:07:20,923 [salt.minion      ][INFO    ][22941] Starting a new job with PID 22941
2017-09-14 21:07:20,941 [salt.minion      ][INFO    ][22941] Returning information for job: 20170914210720868360
2017-09-14 21:07:30,936 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210730915839
2017-09-14 21:07:30,959 [salt.minion      ][INFO    ][22946] Starting a new job with PID 22946
2017-09-14 21:07:30,977 [salt.minion      ][INFO    ][22946] Returning information for job: 20170914210730915839
2017-09-14 21:07:40,967 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210740956051
2017-09-14 21:07:40,989 [salt.minion      ][INFO    ][22951] Starting a new job with PID 22951
2017-09-14 21:07:41,008 [salt.minion      ][INFO    ][22951] Returning information for job: 20170914210740956051
2017-09-14 21:07:50,997 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210750987417
2017-09-14 21:07:51,018 [salt.minion      ][INFO    ][22956] Starting a new job with PID 22956
2017-09-14 21:07:51,036 [salt.minion      ][INFO    ][22956] Returning information for job: 20170914210750987417
2017-09-14 21:08:01,034 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210801020444
2017-09-14 21:08:01,056 [salt.minion      ][INFO    ][22961] Starting a new job with PID 22961
2017-09-14 21:08:01,074 [salt.minion      ][INFO    ][22961] Returning information for job: 20170914210801020444
2017-09-14 21:08:11,073 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210811059156
2017-09-14 21:08:11,095 [salt.minion      ][INFO    ][22966] Starting a new job with PID 22966
2017-09-14 21:08:11,113 [salt.minion      ][INFO    ][22966] Returning information for job: 20170914210811059156
2017-09-14 21:08:21,114 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210821103662
2017-09-14 21:08:21,137 [salt.minion      ][INFO    ][22971] Starting a new job with PID 22971
2017-09-14 21:08:21,156 [salt.minion      ][INFO    ][22971] Returning information for job: 20170914210821103662
2017-09-14 21:08:31,160 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210831150110
2017-09-14 21:08:31,183 [salt.minion      ][INFO    ][22977] Starting a new job with PID 22977
2017-09-14 21:08:31,201 [salt.minion      ][INFO    ][22977] Returning information for job: 20170914210831150110
2017-09-14 21:08:41,206 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210841197061
2017-09-14 21:08:41,229 [salt.minion      ][INFO    ][22982] Starting a new job with PID 22982
2017-09-14 21:08:41,247 [salt.minion      ][INFO    ][22982] Returning information for job: 20170914210841197061
2017-09-14 21:08:51,260 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210851249160
2017-09-14 21:08:51,282 [salt.minion      ][INFO    ][22987] Starting a new job with PID 22987
2017-09-14 21:08:51,300 [salt.minion      ][INFO    ][22987] Returning information for job: 20170914210851249160
2017-09-14 21:09:01,315 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210901305499
2017-09-14 21:09:01,338 [salt.minion      ][INFO    ][22992] Starting a new job with PID 22992
2017-09-14 21:09:01,357 [salt.minion      ][INFO    ][22992] Returning information for job: 20170914210901305499
2017-09-14 21:09:11,376 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210911366636
2017-09-14 21:09:11,398 [salt.minion      ][INFO    ][22997] Starting a new job with PID 22997
2017-09-14 21:09:11,414 [salt.minion      ][INFO    ][22997] Returning information for job: 20170914210911366636
2017-09-14 21:09:21,436 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210921427247
2017-09-14 21:09:21,459 [salt.minion      ][INFO    ][23002] Starting a new job with PID 23002
2017-09-14 21:09:21,478 [salt.minion      ][INFO    ][23002] Returning information for job: 20170914210921427247
2017-09-14 21:09:31,506 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210931495873
2017-09-14 21:09:31,528 [salt.minion      ][INFO    ][23007] Starting a new job with PID 23007
2017-09-14 21:09:31,548 [salt.minion      ][INFO    ][23007] Returning information for job: 20170914210931495873
2017-09-14 21:09:41,582 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210941571962
2017-09-14 21:09:41,604 [salt.minion      ][INFO    ][23012] Starting a new job with PID 23012
2017-09-14 21:09:41,623 [salt.minion      ][INFO    ][23012] Returning information for job: 20170914210941571962
2017-09-14 21:09:51,655 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914210951644729
2017-09-14 21:09:51,678 [salt.minion      ][INFO    ][23017] Starting a new job with PID 23017
2017-09-14 21:09:51,695 [salt.minion      ][INFO    ][23017] Returning information for job: 20170914210951644729
2017-09-14 21:10:01,740 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211001730373
2017-09-14 21:10:01,764 [salt.minion      ][INFO    ][23022] Starting a new job with PID 23022
2017-09-14 21:10:01,782 [salt.minion      ][INFO    ][23022] Returning information for job: 20170914211001730373
2017-09-14 21:10:11,829 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211011818929
2017-09-14 21:10:11,851 [salt.minion      ][INFO    ][23027] Starting a new job with PID 23027
2017-09-14 21:10:11,869 [salt.minion      ][INFO    ][23027] Returning information for job: 20170914211011818929
2017-09-14 21:10:21,926 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211021911362
2017-09-14 21:10:21,949 [salt.minion      ][INFO    ][23032] Starting a new job with PID 23032
2017-09-14 21:10:21,966 [salt.minion      ][INFO    ][23032] Returning information for job: 20170914211021911362
2017-09-14 21:10:32,022 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211032012270
2017-09-14 21:10:32,045 [salt.minion      ][INFO    ][23037] Starting a new job with PID 23037
2017-09-14 21:10:32,063 [salt.minion      ][INFO    ][23037] Returning information for job: 20170914211032012270
2017-09-14 21:10:42,121 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211042110451
2017-09-14 21:10:42,143 [salt.minion      ][INFO    ][23042] Starting a new job with PID 23042
2017-09-14 21:10:42,161 [salt.minion      ][INFO    ][23042] Returning information for job: 20170914211042110451
2017-09-14 21:10:52,232 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211052214910
2017-09-14 21:10:52,254 [salt.minion      ][INFO    ][23047] Starting a new job with PID 23047
2017-09-14 21:10:52,273 [salt.minion      ][INFO    ][23047] Returning information for job: 20170914211052214910
2017-09-14 21:11:02,346 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211102335763
2017-09-14 21:11:02,367 [salt.minion      ][INFO    ][23052] Starting a new job with PID 23052
2017-09-14 21:11:02,386 [salt.minion      ][INFO    ][23052] Returning information for job: 20170914211102335763
2017-09-14 21:11:12,465 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211112455189
2017-09-14 21:11:12,487 [salt.minion      ][INFO    ][23057] Starting a new job with PID 23057
2017-09-14 21:11:12,505 [salt.minion      ][INFO    ][23057] Returning information for job: 20170914211112455189
2017-09-14 21:11:22,590 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211122582133
2017-09-14 21:11:22,614 [salt.minion      ][INFO    ][23062] Starting a new job with PID 23062
2017-09-14 21:11:22,632 [salt.minion      ][INFO    ][23062] Returning information for job: 20170914211122582133
2017-09-14 21:11:32,723 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211132713586
2017-09-14 21:11:32,746 [salt.minion      ][INFO    ][23067] Starting a new job with PID 23067
2017-09-14 21:11:32,765 [salt.minion      ][INFO    ][23067] Returning information for job: 20170914211132713586
2017-09-14 21:11:42,862 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211142852545
2017-09-14 21:11:42,884 [salt.minion      ][INFO    ][23082] Starting a new job with PID 23082
2017-09-14 21:11:42,902 [salt.minion      ][INFO    ][23082] Returning information for job: 20170914211142852545
2017-09-14 21:11:53,008 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211152997452
2017-09-14 21:11:53,030 [salt.minion      ][INFO    ][23087] Starting a new job with PID 23087
2017-09-14 21:11:53,048 [salt.minion      ][INFO    ][23087] Returning information for job: 20170914211152997452
2017-09-14 21:12:03,158 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211203149091
2017-09-14 21:12:03,181 [salt.minion      ][INFO    ][23092] Starting a new job with PID 23092
2017-09-14 21:12:03,199 [salt.minion      ][INFO    ][23092] Returning information for job: 20170914211203149091
2017-09-14 21:12:13,317 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211213306090
2017-09-14 21:12:13,340 [salt.minion      ][INFO    ][23097] Starting a new job with PID 23097
2017-09-14 21:12:13,358 [salt.minion      ][INFO    ][23097] Returning information for job: 20170914211213306090
2017-09-14 21:12:23,483 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211223473282
2017-09-14 21:12:23,503 [salt.minion      ][INFO    ][23102] Starting a new job with PID 23102
2017-09-14 21:12:23,520 [salt.minion      ][INFO    ][23102] Returning information for job: 20170914211223473282
2017-09-14 21:12:33,652 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211233642709
2017-09-14 21:12:33,673 [salt.minion      ][INFO    ][23107] Starting a new job with PID 23107
2017-09-14 21:12:33,692 [salt.minion      ][INFO    ][23107] Returning information for job: 20170914211233642709
2017-09-14 21:12:43,828 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211243818980
2017-09-14 21:12:43,850 [salt.minion      ][INFO    ][23112] Starting a new job with PID 23112
2017-09-14 21:12:43,867 [salt.minion      ][INFO    ][23112] Returning information for job: 20170914211243818980
2017-09-14 21:12:54,008 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211253998915
2017-09-14 21:12:54,030 [salt.minion      ][INFO    ][23117] Starting a new job with PID 23117
2017-09-14 21:12:54,049 [salt.minion      ][INFO    ][23117] Returning information for job: 20170914211253998915
2017-09-14 21:13:04,200 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211304190182
2017-09-14 21:13:04,223 [salt.minion      ][INFO    ][23122] Starting a new job with PID 23122
2017-09-14 21:13:04,241 [salt.minion      ][INFO    ][23122] Returning information for job: 20170914211304190182
2017-09-14 21:13:14,402 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211314393039
2017-09-14 21:13:14,424 [salt.minion      ][INFO    ][23127] Starting a new job with PID 23127
2017-09-14 21:13:14,442 [salt.minion      ][INFO    ][23127] Returning information for job: 20170914211314393039
2017-09-14 21:13:24,607 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211324598571
2017-09-14 21:13:24,628 [salt.minion      ][INFO    ][23132] Starting a new job with PID 23132
2017-09-14 21:13:24,646 [salt.minion      ][INFO    ][23132] Returning information for job: 20170914211324598571
2017-09-14 21:13:34,815 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211334806101
2017-09-14 21:13:34,838 [salt.minion      ][INFO    ][23137] Starting a new job with PID 23137
2017-09-14 21:13:34,856 [salt.minion      ][INFO    ][23137] Returning information for job: 20170914211334806101
2017-09-14 21:13:45,032 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211345022998
2017-09-14 21:13:45,053 [salt.minion      ][INFO    ][23142] Starting a new job with PID 23142
2017-09-14 21:13:45,071 [salt.minion      ][INFO    ][23142] Returning information for job: 20170914211345022998
2017-09-14 21:13:55,257 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211355247109
2017-09-14 21:13:55,279 [salt.minion      ][INFO    ][23147] Starting a new job with PID 23147
2017-09-14 21:13:55,297 [salt.minion      ][INFO    ][23147] Returning information for job: 20170914211355247109
2017-09-14 21:13:59,174 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-09-14 21:13:59,214 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 21:13:59,271 [salt.loaded.int.module.cmdmod][ERROR   ][22773] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-14 21:13:59,271 [salt.loaded.int.module.cmdmod][ERROR   ][22773] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-14 21:13:59,272 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/prx01.baremetal-mcp-ocata-odl-ha.local/system.qcow2' in directory '/root'
2017-09-14 21:13:59,304 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 21:13:59,321 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-09-14 21:14:00,387 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-09-14 21:14:01,025 [salt.loaded.ext.module.seedng][INFO    ][22773] salt-minion pre-installed on image, configuring as prx01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:14:01,034 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'mount -l' in directory '/root'
2017-09-14 21:14:01,085 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-09-14 21:14:01,989 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-09-14 21:14:04,208 [salt.state       ][INFO    ][22773] {'ret': True}
2017-09-14 21:14:04,209 [salt.state       ][INFO    ][22773] Completed state [virtng.init] at time 21:14:04.208554 duration_in_ms=592115.973
2017-09-14 21:14:04,209 [salt.state       ][INFO    ][22773] Running state [virt.set_autostart] at time 21:14:04.209222
2017-09-14 21:14:04,210 [salt.state       ][INFO    ][22773] Executing state module.run for virt.set_autostart
2017-09-14 21:14:04,215 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-14 21:14:04,256 [salt.state       ][INFO    ][22773] {'ret': True}
2017-09-14 21:14:04,256 [salt.state       ][INFO    ][22773] Completed state [virt.set_autostart] at time 21:14:04.256122 duration_in_ms=46.899
2017-09-14 21:14:04,257 [salt.state       ][INFO    ][22773] Running state [virtng.init] at time 21:14:04.256569
2017-09-14 21:14:04,257 [salt.state       ][INFO    ][22773] Executing state module.run for virtng.init
2017-09-14 21:14:04,262 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-14 21:14:05,275 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211405265928
2017-09-14 21:14:05,297 [salt.minion      ][INFO    ][23556] Starting a new job with PID 23556
2017-09-14 21:14:05,314 [salt.minion      ][INFO    ][23556] Returning information for job: 20170914211405265928
2017-09-14 21:14:06,800 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-09-14 21:14:06,817 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 21:14:06,829 [salt.loaded.int.module.cmdmod][ERROR   ][22773] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-14 21:14:06,830 [salt.loaded.int.module.cmdmod][ERROR   ][22773] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-14 21:14:06,830 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/mdb01.baremetal-mcp-ocata-odl-ha.local/system.qcow2' in directory '/root'
2017-09-14 21:14:06,862 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 21:14:06,877 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-09-14 21:14:07,932 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-09-14 21:14:08,668 [salt.loaded.ext.module.seedng][INFO    ][22773] salt-minion pre-installed on image, configuring as mdb01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:14:08,679 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'mount -l' in directory '/root'
2017-09-14 21:14:08,828 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-09-14 21:14:10,857 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-09-14 21:14:13,046 [salt.state       ][INFO    ][22773] {'ret': True}
2017-09-14 21:14:13,047 [salt.state       ][INFO    ][22773] Completed state [virtng.init] at time 21:14:13.046841 duration_in_ms=8790.268
2017-09-14 21:14:13,048 [salt.state       ][INFO    ][22773] Running state [virt.set_autostart] at time 21:14:13.047439
2017-09-14 21:14:13,048 [salt.state       ][INFO    ][22773] Executing state module.run for virt.set_autostart
2017-09-14 21:14:13,053 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-14 21:14:13,095 [salt.state       ][INFO    ][22773] {'ret': True}
2017-09-14 21:14:13,096 [salt.state       ][INFO    ][22773] Completed state [virt.set_autostart] at time 21:14:13.095794 duration_in_ms=48.353
2017-09-14 21:14:13,097 [salt.state       ][INFO    ][22773] Running state [virtng.init] at time 21:14:13.096459
2017-09-14 21:14:13,097 [salt.state       ][INFO    ][22773] Executing state module.run for virtng.init
2017-09-14 21:14:13,102 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-14 21:14:15,301 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211415290322
2017-09-14 21:14:15,321 [salt.minion      ][INFO    ][23827] Starting a new job with PID 23827
2017-09-14 21:14:15,338 [salt.minion      ][INFO    ][23827] Returning information for job: 20170914211415290322
2017-09-14 21:14:15,683 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-09-14 21:14:15,701 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 21:14:15,715 [salt.loaded.int.module.cmdmod][ERROR   ][22773] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-14 21:14:15,716 [salt.loaded.int.module.cmdmod][ERROR   ][22773] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-14 21:14:15,716 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/msg01.baremetal-mcp-ocata-odl-ha.local/system.qcow2' in directory '/root'
2017-09-14 21:14:15,751 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 21:14:15,765 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-09-14 21:14:16,828 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-09-14 21:14:17,505 [salt.loaded.ext.module.seedng][INFO    ][22773] salt-minion pre-installed on image, configuring as msg01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:14:17,515 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'mount -l' in directory '/root'
2017-09-14 21:14:17,953 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-09-14 21:14:20,560 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-09-14 21:14:22,717 [salt.state       ][INFO    ][22773] {'ret': True}
2017-09-14 21:14:22,718 [salt.state       ][INFO    ][22773] Completed state [virtng.init] at time 21:14:22.718054 duration_in_ms=9621.591
2017-09-14 21:14:22,719 [salt.state       ][INFO    ][22773] Running state [virt.set_autostart] at time 21:14:22.718649
2017-09-14 21:14:22,719 [salt.state       ][INFO    ][22773] Executing state module.run for virt.set_autostart
2017-09-14 21:14:22,725 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-14 21:14:22,764 [salt.state       ][INFO    ][22773] {'ret': True}
2017-09-14 21:14:22,765 [salt.state       ][INFO    ][22773] Completed state [virt.set_autostart] at time 21:14:22.764778 duration_in_ms=46.128
2017-09-14 21:14:22,765 [salt.state       ][INFO    ][22773] Running state [virtng.init] at time 21:14:22.765172
2017-09-14 21:14:22,766 [salt.state       ][INFO    ][22773] Executing state module.run for virtng.init
2017-09-14 21:14:22,770 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-14 21:14:25,329 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211425319462
2017-09-14 21:14:25,349 [salt.minion      ][INFO    ][24105] Starting a new job with PID 24105
2017-09-14 21:14:25,364 [salt.minion      ][INFO    ][24105] Returning information for job: 20170914211425319462
2017-09-14 21:14:27,849 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-09-14 21:14:27,866 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 21:14:27,983 [salt.loaded.int.module.cmdmod][ERROR   ][22773] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-14 21:14:27,984 [salt.loaded.int.module.cmdmod][ERROR   ][22773] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-14 21:14:27,985 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/dbs01.baremetal-mcp-ocata-odl-ha.local/system.qcow2' in directory '/root'
2017-09-14 21:14:28,019 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 21:14:28,034 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-09-14 21:14:29,080 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-09-14 21:14:29,874 [salt.loaded.ext.module.seedng][INFO    ][22773] salt-minion pre-installed on image, configuring as dbs01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:14:29,990 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'mount -l' in directory '/root'
2017-09-14 21:14:30,297 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-09-14 21:14:31,358 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-09-14 21:14:33,514 [salt.state       ][INFO    ][22773] {'ret': True}
2017-09-14 21:14:33,515 [salt.state       ][INFO    ][22773] Completed state [virtng.init] at time 21:14:33.514517 duration_in_ms=10749.341
2017-09-14 21:14:33,515 [salt.state       ][INFO    ][22773] Running state [virt.set_autostart] at time 21:14:33.515037
2017-09-14 21:14:33,516 [salt.state       ][INFO    ][22773] Executing state module.run for virt.set_autostart
2017-09-14 21:14:33,521 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-14 21:14:33,557 [salt.state       ][INFO    ][22773] {'ret': True}
2017-09-14 21:14:33,558 [salt.state       ][INFO    ][22773] Completed state [virt.set_autostart] at time 21:14:33.557789 duration_in_ms=42.751
2017-09-14 21:14:33,558 [salt.state       ][INFO    ][22773] Running state [virtng.init] at time 21:14:33.558133
2017-09-14 21:14:33,558 [salt.state       ][INFO    ][22773] Executing state module.run for virtng.init
2017-09-14 21:14:33,562 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-14 21:14:35,364 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211435354255
2017-09-14 21:14:35,385 [salt.minion      ][INFO    ][24374] Starting a new job with PID 24374
2017-09-14 21:14:35,402 [salt.minion      ][INFO    ][24374] Returning information for job: 20170914211435354255
2017-09-14 21:14:37,382 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-09-14 21:14:37,399 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 21:14:37,412 [salt.loaded.int.module.cmdmod][ERROR   ][22773] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-14 21:14:37,509 [salt.loaded.int.module.cmdmod][ERROR   ][22773] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-14 21:14:37,510 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/ctl01.baremetal-mcp-ocata-odl-ha.local/system.qcow2' in directory '/root'
2017-09-14 21:14:37,544 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 21:14:37,560 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-09-14 21:14:38,607 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-09-14 21:14:39,594 [salt.loaded.ext.module.seedng][INFO    ][22773] salt-minion pre-installed on image, configuring as ctl01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:14:39,605 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'mount -l' in directory '/root'
2017-09-14 21:14:39,779 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-09-14 21:14:41,417 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-09-14 21:14:43,584 [salt.state       ][INFO    ][22773] {'ret': True}
2017-09-14 21:14:43,585 [salt.state       ][INFO    ][22773] Completed state [virtng.init] at time 21:14:43.584611 duration_in_ms=10026.474
2017-09-14 21:14:43,585 [salt.state       ][INFO    ][22773] Running state [virt.set_autostart] at time 21:14:43.585154
2017-09-14 21:14:43,586 [salt.state       ][INFO    ][22773] Executing state module.run for virt.set_autostart
2017-09-14 21:14:43,591 [salt.loaded.int.module.cmdmod][INFO    ][22773] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-09-14 21:14:43,628 [salt.state       ][INFO    ][22773] {'ret': True}
2017-09-14 21:14:43,629 [salt.state       ][INFO    ][22773] Completed state [virt.set_autostart] at time 21:14:43.628823 duration_in_ms=43.669
2017-09-14 21:14:43,633 [salt.minion      ][INFO    ][22773] Returning information for job: 20170914210408091613
2017-09-14 21:14:44,634 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command pillar.get with jid 20170914211444625187
2017-09-14 21:14:44,656 [salt.minion      ][INFO    ][24650] Starting a new job with PID 24650
2017-09-14 21:14:44,661 [salt.minion      ][INFO    ][24650] Returning information for job: 20170914211444625187
2017-09-14 21:16:25,007 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170914211624997576
2017-09-14 21:16:25,034 [salt.minion      ][INFO    ][24683] Starting a new job with PID 24683
2017-09-14 21:16:29,531 [salt.state       ][INFO    ][24683] Loading fresh modules for state activity
2017-09-14 21:16:29,628 [salt.state       ][ERROR   ][24683] No contents found in top file
2017-09-14 21:16:29,629 [salt.utils.extmods][INFO    ][24683] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-14 21:16:29,633 [salt.utils.extmods][INFO    ][24683] Syncing beacons for environment 'base'
2017-09-14 21:16:29,634 [salt.utils.extmods][INFO    ][24683] Loading cache from salt://_beacons, for base)
2017-09-14 21:16:29,634 [salt.fileclient  ][INFO    ][24683] Caching directory '_beacons/' for environment 'base'
2017-09-14 21:16:29,695 [salt.utils.extmods][INFO    ][24683] Syncing modules for environment 'base'
2017-09-14 21:16:29,695 [salt.utils.extmods][INFO    ][24683] Loading cache from salt://_modules, for base)
2017-09-14 21:16:29,695 [salt.fileclient  ][INFO    ][24683] Caching directory '_modules/' for environment 'base'
2017-09-14 21:16:29,733 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-14 21:16:30,036 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-14 21:16:30,052 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-14 21:16:30,100 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-14 21:16:30,119 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-14 21:16:30,179 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-14 21:16:30,238 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-14 21:16:30,265 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-14 21:16:30,287 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-14 21:16:30,299 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-14 21:16:30,323 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-14 21:16:30,342 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-14 21:16:30,365 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-14 21:16:30,398 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-14 21:16:30,429 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-14 21:16:30,450 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-14 21:16:30,507 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-14 21:16:30,572 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-14 21:16:30,639 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-14 21:16:30,668 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-14 21:16:30,694 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-14 21:16:30,713 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-14 21:16:30,739 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-14 21:16:30,786 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-14 21:16:30,830 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-14 21:16:30,844 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-14 21:16:30,878 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-14 21:16:30,906 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-14 21:16:31,032 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-14 21:16:31,046 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-14 21:16:31,057 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-14 21:16:31,074 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-14 21:16:31,081 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-14 21:16:31,082 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-14 21:16:31,082 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-14 21:16:31,083 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-14 21:16:31,084 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-14 21:16:31,084 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-14 21:16:31,085 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-14 21:16:31,085 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-14 21:16:31,086 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-14 21:16:31,086 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-14 21:16:31,087 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-14 21:16:31,088 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-14 21:16:31,088 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-14 21:16:31,089 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-14 21:16:31,089 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-14 21:16:31,090 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-14 21:16:31,090 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-14 21:16:31,091 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-14 21:16:31,091 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-14 21:16:31,092 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-14 21:16:31,092 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-14 21:16:31,093 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-14 21:16:31,094 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-14 21:16:31,095 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-14 21:16:31,095 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-14 21:16:31,096 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-14 21:16:31,096 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-14 21:16:31,097 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-14 21:16:31,097 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-14 21:16:31,098 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-14 21:16:31,098 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-14 21:16:31,099 [salt.utils.extmods][INFO    ][24683] 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-14 21:16:31,099 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-14 21:16:31,100 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-14 21:16:31,109 [salt.utils.extmods][INFO    ][24683] Syncing states for environment 'base'
2017-09-14 21:16:31,109 [salt.utils.extmods][INFO    ][24683] Loading cache from salt://_states, for base)
2017-09-14 21:16:31,109 [salt.fileclient  ][INFO    ][24683] Caching directory '_states/' for environment 'base'
2017-09-14 21:16:31,154 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-14 21:16:31,205 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-14 21:16:31,303 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-14 21:16:31,342 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-14 21:16:31,368 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-14 21:16:31,429 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-14 21:16:31,526 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-14 21:16:31,556 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-14 21:16:31,642 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-14 21:16:31,707 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-14 21:16:31,744 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-14 21:16:31,759 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-14 21:16:31,805 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-14 21:16:31,877 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-14 21:16:31,900 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-14 21:16:31,943 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-14 21:16:31,970 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-14 21:16:31,996 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-14 21:16:32,075 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-14 21:16:32,104 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-14 21:16:32,121 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-14 21:16:32,141 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-14 21:16:32,152 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-14 21:16:32,212 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-14 21:16:32,227 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-14 21:16:32,238 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-14 21:16:32,247 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-14 21:16:32,260 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-14 21:16:32,278 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-14 21:16:32,283 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-14 21:16:32,283 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-14 21:16:32,284 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-14 21:16:32,284 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-14 21:16:32,285 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-14 21:16:32,285 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-14 21:16:32,285 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-14 21:16:32,286 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-14 21:16:32,286 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-14 21:16:32,287 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-14 21:16:32,287 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-14 21:16:32,287 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-14 21:16:32,288 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-14 21:16:32,288 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-14 21:16:32,288 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-14 21:16:32,289 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-14 21:16:32,289 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-14 21:16:32,289 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-14 21:16:32,290 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-14 21:16:32,290 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-14 21:16:32,290 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-14 21:16:32,291 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-14 21:16:32,291 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-14 21:16:32,292 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-14 21:16:32,292 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-14 21:16:32,292 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-14 21:16:32,293 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-14 21:16:32,293 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-14 21:16:32,294 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-14 21:16:32,294 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-14 21:16:32,297 [salt.utils.extmods][INFO    ][24683] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-14 21:16:32,303 [salt.utils.extmods][INFO    ][24683] Syncing sdb for environment 'base'
2017-09-14 21:16:32,304 [salt.utils.extmods][INFO    ][24683] Loading cache from salt://_sdb, for base)
2017-09-14 21:16:32,304 [salt.fileclient  ][INFO    ][24683] Caching directory '_sdb/' for environment 'base'
2017-09-14 21:16:32,383 [salt.utils.extmods][INFO    ][24683] Syncing grains for environment 'base'
2017-09-14 21:16:32,383 [salt.utils.extmods][INFO    ][24683] Loading cache from salt://_grains, for base)
2017-09-14 21:16:32,383 [salt.fileclient  ][INFO    ][24683] Caching directory '_grains/' for environment 'base'
2017-09-14 21:16:32,470 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-14 21:16:32,481 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-14 21:16:32,532 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-14 21:16:32,550 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-14 21:16:32,566 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-14 21:16:32,622 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-14 21:16:32,647 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-14 21:16:32,680 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-14 21:16:32,693 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-14 21:16:32,761 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-14 21:16:32,773 [salt.fileclient  ][INFO    ][24683] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-14 21:16:32,777 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-14 21:16:32,777 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-14 21:16:32,778 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-14 21:16:32,778 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-14 21:16:32,778 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-14 21:16:32,779 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-14 21:16:32,779 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-14 21:16:32,779 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-14 21:16:32,780 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-14 21:16:32,780 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-14 21:16:32,780 [salt.utils.extmods][INFO    ][24683] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-14 21:16:32,782 [salt.utils.extmods][INFO    ][24683] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-14 21:16:32,788 [salt.utils.extmods][INFO    ][24683] Syncing renderers for environment 'base'
2017-09-14 21:16:32,788 [salt.utils.extmods][INFO    ][24683] Loading cache from salt://_renderers, for base)
2017-09-14 21:16:32,789 [salt.fileclient  ][INFO    ][24683] Caching directory '_renderers/' for environment 'base'
2017-09-14 21:16:32,933 [salt.utils.extmods][INFO    ][24683] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-14 21:16:32,938 [salt.utils.extmods][INFO    ][24683] Syncing returners for environment 'base'
2017-09-14 21:16:32,938 [salt.utils.extmods][INFO    ][24683] Loading cache from salt://_returners, for base)
2017-09-14 21:16:32,938 [salt.fileclient  ][INFO    ][24683] Caching directory '_returners/' for environment 'base'
2017-09-14 21:16:32,994 [salt.utils.extmods][INFO    ][24683] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-14 21:16:32,999 [salt.utils.extmods][INFO    ][24683] Syncing output for environment 'base'
2017-09-14 21:16:32,999 [salt.utils.extmods][INFO    ][24683] Loading cache from salt://_output, for base)
2017-09-14 21:16:32,999 [salt.fileclient  ][INFO    ][24683] Caching directory '_output/' for environment 'base'
2017-09-14 21:16:33,047 [salt.utils.extmods][INFO    ][24683] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-14 21:16:33,052 [salt.utils.extmods][INFO    ][24683] Syncing utils for environment 'base'
2017-09-14 21:16:33,052 [salt.utils.extmods][INFO    ][24683] Loading cache from salt://_utils, for base)
2017-09-14 21:16:33,053 [salt.fileclient  ][INFO    ][24683] Caching directory '_utils/' for environment 'base'
2017-09-14 21:16:33,150 [salt.utils.extmods][INFO    ][24683] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-14 21:16:33,155 [salt.utils.extmods][INFO    ][24683] Syncing log_handlers for environment 'base'
2017-09-14 21:16:33,156 [salt.utils.extmods][INFO    ][24683] Loading cache from salt://_log_handlers, for base)
2017-09-14 21:16:33,156 [salt.fileclient  ][INFO    ][24683] Caching directory '_log_handlers/' for environment 'base'
2017-09-14 21:16:33,274 [salt.utils.extmods][INFO    ][24683] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-14 21:16:33,279 [salt.utils.extmods][INFO    ][24683] Syncing proxy for environment 'base'
2017-09-14 21:16:33,280 [salt.utils.extmods][INFO    ][24683] Loading cache from salt://_proxy, for base)
2017-09-14 21:16:33,280 [salt.fileclient  ][INFO    ][24683] Caching directory '_proxy/' for environment 'base'
2017-09-14 21:16:33,337 [salt.utils.extmods][INFO    ][24683] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-14 21:16:33,342 [salt.utils.extmods][INFO    ][24683] Syncing engines for environment 'base'
2017-09-14 21:16:33,343 [salt.utils.extmods][INFO    ][24683] Loading cache from salt://_engines, for base)
2017-09-14 21:16:33,343 [salt.fileclient  ][INFO    ][24683] Caching directory '_engines/' for environment 'base'
2017-09-14 21:16:33,379 [salt.minion      ][INFO    ][24683] Returning information for job: 20170914211624997576
2017-09-14 21:33:32,045 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command test.ping with jid 20170914213332042470
2017-09-14 21:33:32,070 [salt.minion      ][INFO    ][25091] Starting a new job with PID 25091
2017-09-14 21:33:32,148 [salt.minion      ][INFO    ][25091] Returning information for job: 20170914213332042470
2017-09-14 21:34:36,352 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command state.sls with jid 20170914213436345514
2017-09-14 21:34:36,377 [salt.minion      ][INFO    ][25108] Starting a new job with PID 25108
2017-09-14 21:34:36,814 [salt.state       ][INFO    ][25108] Loading fresh modules for state activity
2017-09-14 21:34:36,859 [salt.fileclient  ][INFO    ][25108] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-14 21:34:36,885 [salt.fileclient  ][INFO    ][25108] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-14 21:34:36,922 [salt.fileclient  ][INFO    ][25108] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-14 21:34:37,292 [salt.state       ][INFO    ][25108] Running state [lsof] at time 21:34:37.291928
2017-09-14 21:34:37,292 [salt.state       ][INFO    ][25108] Executing state pkg.installed for lsof
2017-09-14 21:34:37,293 [salt.loaded.int.module.cmdmod][INFO    ][25108] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:34:37,680 [salt.state       ][INFO    ][25108] Package lsof is already installed
2017-09-14 21:34:37,680 [salt.state       ][INFO    ][25108] Completed state [lsof] at time 21:34:37.679865 duration_in_ms=387.936
2017-09-14 21:34:37,680 [salt.state       ][INFO    ][25108] Running state [keepalived] at time 21:34:37.680084
2017-09-14 21:34:37,680 [salt.state       ][INFO    ][25108] Executing state pkg.installed for keepalived
2017-09-14 21:34:37,700 [salt.loaded.int.module.cmdmod][INFO    ][25108] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:34:44,493 [salt.loaded.int.module.cmdmod][INFO    ][25108] 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-14 21:34:46,397 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914213446388938
2017-09-14 21:34:46,418 [salt.minion      ][INFO    ][25720] Starting a new job with PID 25720
2017-09-14 21:34:46,449 [salt.minion      ][INFO    ][25720] Returning information for job: 20170914213446388938
2017-09-14 21:34:54,335 [salt.loaded.int.module.cmdmod][INFO    ][25108] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:34:54,389 [salt.state       ][INFO    ][25108] 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-14 21:34:54,428 [salt.state       ][INFO    ][25108] Loading fresh modules for state activity
2017-09-14 21:34:54,457 [salt.state       ][INFO    ][25108] Completed state [keepalived] at time 21:34:54.456766 duration_in_ms=16776.68
2017-09-14 21:34:54,460 [salt.state       ][INFO    ][25108] Running state [/etc/keepalived/keepalived.conf] at time 21:34:54.460327
2017-09-14 21:34:54,461 [salt.state       ][INFO    ][25108] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-14 21:34:54,498 [salt.fileclient  ][INFO    ][25108] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-14 21:34:54,553 [salt.fileclient  ][INFO    ][25108] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-14 21:34:54,567 [salt.state       ][INFO    ][25108] File changed:
New file
2017-09-14 21:34:54,567 [salt.state       ][INFO    ][25108] Completed state [/etc/keepalived/keepalived.conf] at time 21:34:54.567029 duration_in_ms=106.701
2017-09-14 21:34:54,670 [salt.state       ][INFO    ][25108] Running state [keepalived] at time 21:34:54.669724
2017-09-14 21:34:54,670 [salt.state       ][INFO    ][25108] Executing state service.running for keepalived
2017-09-14 21:34:54,673 [salt.loaded.int.module.cmdmod][INFO    ][25108] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-14 21:34:54,685 [salt.loaded.int.module.cmdmod][INFO    ][25108] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-14 21:34:54,697 [salt.loaded.int.module.cmdmod][INFO    ][25108] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-14 21:34:54,711 [salt.loaded.int.module.cmdmod][INFO    ][25108] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-14 21:34:54,725 [salt.loaded.int.module.cmdmod][INFO    ][25108] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-14 21:34:54,797 [salt.loaded.int.module.cmdmod][INFO    ][25108] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-14 21:34:54,812 [salt.loaded.int.module.cmdmod][INFO    ][25108] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-14 21:34:54,829 [salt.loaded.int.module.cmdmod][INFO    ][25108] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-14 21:34:54,840 [salt.state       ][INFO    ][25108] {'keepalived': True}
2017-09-14 21:34:54,840 [salt.state       ][INFO    ][25108] Completed state [keepalived] at time 21:34:54.840318 duration_in_ms=170.594
2017-09-14 21:34:54,842 [salt.minion      ][INFO    ][25108] Returning information for job: 20170914213436345514
2017-09-14 21:37:50,880 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command pillar.get with jid 20170914213750873401
2017-09-14 21:37:50,906 [salt.minion      ][INFO    ][26749] Starting a new job with PID 26749
2017-09-14 21:37:50,912 [salt.minion      ][INFO    ][26749] Returning information for job: 20170914213750873401
2017-09-14 21:44:12,121 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command state.sls with jid 20170914214412113761
2017-09-14 21:44:12,143 [salt.minion      ][INFO    ][26882] Starting a new job with PID 26882
2017-09-14 21:44:14,583 [salt.state       ][INFO    ][26882] Loading fresh modules for state activity
2017-09-14 21:44:14,623 [salt.fileclient  ][INFO    ][26882] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-14 21:44:14,659 [salt.fileclient  ][INFO    ][26882] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-14 21:44:15,111 [salt.state       ][INFO    ][26882] Running state [attr] at time 21:44:15.110854
2017-09-14 21:44:15,111 [salt.state       ][INFO    ][26882] Executing state pkg.installed for attr
2017-09-14 21:44:15,112 [salt.loaded.int.module.cmdmod][INFO    ][26882] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:44:15,592 [salt.loaded.int.module.cmdmod][INFO    ][26882] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:44:17,823 [salt.loaded.int.module.cmdmod][INFO    ][26882] 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-14 21:44:20,988 [salt.loaded.int.module.cmdmod][INFO    ][26882] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:44:21,044 [salt.state       ][INFO    ][26882] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-14 21:44:21,061 [salt.state       ][INFO    ][26882] Loading fresh modules for state activity
2017-09-14 21:44:21,079 [salt.state       ][INFO    ][26882] Completed state [attr] at time 21:44:21.078700 duration_in_ms=5967.845
2017-09-14 21:44:21,084 [salt.state       ][INFO    ][26882] Running state [glusterfs-server] at time 21:44:21.084066
2017-09-14 21:44:21,084 [salt.state       ][INFO    ][26882] Executing state pkg.installed for glusterfs-server
2017-09-14 21:44:21,376 [salt.loaded.int.module.cmdmod][INFO    ][26882] 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-14 21:44:22,216 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914214422206879
2017-09-14 21:44:22,240 [salt.minion      ][INFO    ][27871] Starting a new job with PID 27871
2017-09-14 21:44:22,261 [salt.minion      ][INFO    ][27871] Returning information for job: 20170914214422206879
2017-09-14 21:44:32,426 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914214432417040
2017-09-14 21:44:32,450 [salt.minion      ][INFO    ][27985] Starting a new job with PID 27985
2017-09-14 21:44:32,470 [salt.minion      ][INFO    ][27985] Returning information for job: 20170914214432417040
2017-09-14 21:44:42,567 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914214442558574
2017-09-14 21:44:42,589 [salt.minion      ][INFO    ][30766] Starting a new job with PID 30766
2017-09-14 21:44:42,610 [salt.minion      ][INFO    ][30766] Returning information for job: 20170914214442558574
2017-09-14 21:44:47,917 [salt.loaded.int.module.cmdmod][INFO    ][26882] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:44:47,972 [salt.state       ][INFO    ][26882] 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-14 21:44:47,987 [salt.state       ][INFO    ][26882] Loading fresh modules for state activity
2017-09-14 21:44:48,013 [salt.state       ][INFO    ][26882] Completed state [glusterfs-server] at time 21:44:48.012613 duration_in_ms=26928.545
2017-09-14 21:44:48,020 [salt.state       ][INFO    ][26882] Running state [bc] at time 21:44:48.020284
2017-09-14 21:44:48,021 [salt.state       ][INFO    ][26882] Executing state pkg.installed for bc
2017-09-14 21:44:48,317 [salt.loaded.int.module.cmdmod][INFO    ][26882] 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-14 21:44:51,891 [salt.loaded.int.module.cmdmod][INFO    ][26882] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:44:51,945 [salt.state       ][INFO    ][26882] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-14 21:44:51,960 [salt.state       ][INFO    ][26882] Loading fresh modules for state activity
2017-09-14 21:44:51,985 [salt.state       ][INFO    ][26882] Completed state [bc] at time 21:44:51.985343 duration_in_ms=3965.058
2017-09-14 21:44:52,086 [salt.state       ][INFO    ][26882] Running state [glusterfs-server] at time 21:44:52.085738
2017-09-14 21:44:52,086 [salt.state       ][INFO    ][26882] Executing state service.running for glusterfs-server
2017-09-14 21:44:52,088 [salt.loaded.int.module.cmdmod][INFO    ][26882] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-14 21:44:52,105 [salt.loaded.int.module.cmdmod][INFO    ][26882] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-14 21:44:52,118 [salt.loaded.int.module.cmdmod][INFO    ][26882] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-14 21:44:52,135 [salt.state       ][INFO    ][26882] The service glusterfs-server is already running
2017-09-14 21:44:52,135 [salt.state       ][INFO    ][26882] Completed state [glusterfs-server] at time 21:44:52.135430 duration_in_ms=49.691
2017-09-14 21:44:52,138 [salt.state       ][INFO    ][26882] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:44:52.137638
2017-09-14 21:44:52,138 [salt.state       ][INFO    ][26882] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-14 21:44:52,157 [salt.state       ][INFO    ][26882] File changed:
New file
2017-09-14 21:44:52,157 [salt.state       ][INFO    ][26882] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:44:52.156922 duration_in_ms=19.283
2017-09-14 21:44:52,157 [salt.state       ][INFO    ][26882] Running state [/srv/glusterfs/glance] at time 21:44:52.157308
2017-09-14 21:44:52,158 [salt.state       ][INFO    ][26882] Executing state file.directory for /srv/glusterfs/glance
2017-09-14 21:44:52,174 [salt.state       ][INFO    ][26882] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-14 21:44:52,174 [salt.state       ][INFO    ][26882] Completed state [/srv/glusterfs/glance] at time 21:44:52.174325 duration_in_ms=17.017
2017-09-14 21:44:52,175 [salt.state       ][INFO    ][26882] Running state [/srv/glusterfs/keystone-keys] at time 21:44:52.174687
2017-09-14 21:44:52,175 [salt.state       ][INFO    ][26882] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-14 21:44:52,176 [salt.state       ][INFO    ][26882] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-14 21:44:52,176 [salt.state       ][INFO    ][26882] Completed state [/srv/glusterfs/keystone-keys] at time 21:44:52.176276 duration_in_ms=1.589
2017-09-14 21:44:52,177 [salt.state       ][INFO    ][26882] Running state [/srv/glusterfs/nova_instances] at time 21:44:52.176646
2017-09-14 21:44:52,177 [salt.state       ][INFO    ][26882] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-14 21:44:52,178 [salt.state       ][INFO    ][26882] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-14 21:44:52,178 [salt.state       ][INFO    ][26882] Completed state [/srv/glusterfs/nova_instances] at time 21:44:52.178177 duration_in_ms=1.532
2017-09-14 21:44:52,179 [salt.state       ][INFO    ][26882] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:44:52.178529
2017-09-14 21:44:52,179 [salt.state       ][INFO    ][26882] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-14 21:44:52,180 [salt.state       ][INFO    ][26882] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-14 21:44:52,180 [salt.state       ][INFO    ][26882] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:44:52.180051 duration_in_ms=1.522
2017-09-14 21:44:52,182 [salt.minion      ][INFO    ][26882] Returning information for job: 20170914214412113761
2017-09-14 21:44:53,339 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command test.ping with jid 20170914214453331890
2017-09-14 21:44:53,364 [salt.minion      ][INFO    ][31607] Starting a new job with PID 31607
2017-09-14 21:44:53,421 [salt.minion      ][INFO    ][31607] Returning information for job: 20170914214453331890
2017-09-14 21:45:39,688 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command state.sls with jid 20170914214539680256
2017-09-14 21:45:39,710 [salt.minion      ][INFO    ][31829] Starting a new job with PID 31829
2017-09-14 21:45:40,159 [salt.state       ][INFO    ][31829] Loading fresh modules for state activity
2017-09-14 21:45:40,202 [salt.fileclient  ][INFO    ][31829] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-14 21:45:40,254 [salt.fileclient  ][INFO    ][31829] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-14 21:45:40,351 [salt.fileclient  ][INFO    ][31829] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-14 21:45:40,391 [salt.fileclient  ][INFO    ][31829] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-14 21:45:40,807 [salt.state       ][INFO    ][31829] Running state [attr] at time 21:45:40.806490
2017-09-14 21:45:40,807 [salt.state       ][INFO    ][31829] Executing state pkg.installed for attr
2017-09-14 21:45:40,807 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:45:41,186 [salt.state       ][INFO    ][31829] Package attr is already installed
2017-09-14 21:45:41,186 [salt.state       ][INFO    ][31829] Completed state [attr] at time 21:45:41.186374 duration_in_ms=379.885
2017-09-14 21:45:41,187 [salt.state       ][INFO    ][31829] Running state [glusterfs-server] at time 21:45:41.186775
2017-09-14 21:45:41,187 [salt.state       ][INFO    ][31829] Executing state pkg.installed for glusterfs-server
2017-09-14 21:45:41,191 [salt.state       ][INFO    ][31829] Package glusterfs-server is already installed
2017-09-14 21:45:41,191 [salt.state       ][INFO    ][31829] Completed state [glusterfs-server] at time 21:45:41.190708 duration_in_ms=3.933
2017-09-14 21:45:41,191 [salt.state       ][INFO    ][31829] Running state [bc] at time 21:45:41.190889
2017-09-14 21:45:41,191 [salt.state       ][INFO    ][31829] Executing state pkg.installed for bc
2017-09-14 21:45:41,194 [salt.state       ][INFO    ][31829] Package bc is already installed
2017-09-14 21:45:41,194 [salt.state       ][INFO    ][31829] Completed state [bc] at time 21:45:41.193975 duration_in_ms=3.085
2017-09-14 21:45:41,195 [salt.state       ][INFO    ][31829] Running state [glusterfs-server] at time 21:45:41.195413
2017-09-14 21:45:41,196 [salt.state       ][INFO    ][31829] Executing state service.running for glusterfs-server
2017-09-14 21:45:41,196 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-14 21:45:41,212 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-14 21:45:41,297 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-14 21:45:41,326 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-14 21:45:41,341 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-14 21:45:41,360 [salt.state       ][INFO    ][31829] The service glusterfs-server is already running
2017-09-14 21:45:41,360 [salt.state       ][INFO    ][31829] Completed state [glusterfs-server] at time 21:45:41.360002 duration_in_ms=164.587
2017-09-14 21:45:41,365 [salt.state       ][INFO    ][31829] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:45:41.364715
2017-09-14 21:45:41,365 [salt.state       ][INFO    ][31829] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-14 21:45:41,381 [salt.state       ][INFO    ][31829] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-14 21:45:41,382 [salt.state       ][INFO    ][31829] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:45:41.381514 duration_in_ms=16.799
2017-09-14 21:45:41,382 [salt.state       ][INFO    ][31829] Running state [/srv/glusterfs/glance] at time 21:45:41.381916
2017-09-14 21:45:41,382 [salt.state       ][INFO    ][31829] Executing state file.directory for /srv/glusterfs/glance
2017-09-14 21:45:41,383 [salt.state       ][INFO    ][31829] Directory /srv/glusterfs/glance is in the correct state
2017-09-14 21:45:41,384 [salt.state       ][INFO    ][31829] Completed state [/srv/glusterfs/glance] at time 21:45:41.383501 duration_in_ms=1.585
2017-09-14 21:45:41,384 [salt.state       ][INFO    ][31829] Running state [/srv/glusterfs/keystone-keys] at time 21:45:41.383879
2017-09-14 21:45:41,384 [salt.state       ][INFO    ][31829] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-14 21:45:41,385 [salt.state       ][INFO    ][31829] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-14 21:45:41,385 [salt.state       ][INFO    ][31829] Completed state [/srv/glusterfs/keystone-keys] at time 21:45:41.385404 duration_in_ms=1.524
2017-09-14 21:45:41,386 [salt.state       ][INFO    ][31829] Running state [/srv/glusterfs/nova_instances] at time 21:45:41.385794
2017-09-14 21:45:41,386 [salt.state       ][INFO    ][31829] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-14 21:45:41,387 [salt.state       ][INFO    ][31829] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-14 21:45:41,387 [salt.state       ][INFO    ][31829] Completed state [/srv/glusterfs/nova_instances] at time 21:45:41.387286 duration_in_ms=1.492
2017-09-14 21:45:41,388 [salt.state       ][INFO    ][31829] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:45:41.387685
2017-09-14 21:45:41,388 [salt.state       ][INFO    ][31829] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-14 21:45:41,389 [salt.state       ][INFO    ][31829] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-14 21:45:41,389 [salt.state       ][INFO    ][31829] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:45:41.389239 duration_in_ms=1.554
2017-09-14 21:45:41,496 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command ['git', '--version'] in directory '/root'
2017-09-14 21:45:41,627 [salt.state       ][INFO    ][31829] Running state [sleep 5] at time 21:45:41.627057
2017-09-14 21:45:41,627 [salt.state       ][INFO    ][31829] Executing state cmd.wait for sleep 5
2017-09-14 21:45:41,628 [salt.state       ][INFO    ][31829] No changes made for sleep 5
2017-09-14 21:45:41,628 [salt.state       ][INFO    ][31829] Completed state [sleep 5] at time 21:45:41.627708 duration_in_ms=0.652
2017-09-14 21:45:41,628 [salt.state       ][INFO    ][31829] Running state [10.167.4.141] at time 21:45:41.628142
2017-09-14 21:45:41,628 [salt.state       ][INFO    ][31829] Executing state glusterfs.peered for 10.167.4.141
2017-09-14 21:45:41,629 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:41,645 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:41,757 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:41,774 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:41,884 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:41,901 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:42,010 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:42,024 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:42,131 [salt.state       ][INFO    ][31829] Peering with localhost is not needed
2017-09-14 21:45:42,131 [salt.state       ][INFO    ][31829] Completed state [10.167.4.141] at time 21:45:42.131233 duration_in_ms=503.09
2017-09-14 21:45:42,138 [salt.state       ][INFO    ][31829] Running state [10.167.4.142] at time 21:45:42.137462
2017-09-14 21:45:42,138 [salt.state       ][INFO    ][31829] Executing state glusterfs.peered for 10.167.4.142
2017-09-14 21:45:42,139 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:42,156 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:42,267 [salt.state       ][INFO    ][31829] Host 10.167.4.142 already peered
2017-09-14 21:45:42,270 [salt.state       ][INFO    ][31829] Completed state [10.167.4.142] at time 21:45:42.269566 duration_in_ms=132.103
2017-09-14 21:45:42,276 [salt.state       ][INFO    ][31829] Running state [10.167.4.143] at time 21:45:42.275538
2017-09-14 21:45:42,276 [salt.state       ][INFO    ][31829] Executing state glusterfs.peered for 10.167.4.143
2017-09-14 21:45:42,277 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:42,295 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:42,403 [salt.state       ][INFO    ][31829] Host 10.167.4.143 already peered
2017-09-14 21:45:42,404 [salt.state       ][INFO    ][31829] Completed state [10.167.4.143] at time 21:45:42.403885 duration_in_ms=128.346
2017-09-14 21:45:42,406 [salt.state       ][INFO    ][31829] Running state [glance] at time 21:45:42.405862
2017-09-14 21:45:42,406 [salt.state       ][INFO    ][31829] Executing state glusterfs.created for glance
2017-09-14 21:45:42,407 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:42,424 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:42,531 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:42,547 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:42,652 [salt.state       ][INFO    ][31829] Volume glance already exists and is started.
2017-09-14 21:45:42,653 [salt.state       ][INFO    ][31829] Completed state [glance] at time 21:45:42.652452 duration_in_ms=246.589
2017-09-14 21:45:42,660 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:45:42.659815
2017-09-14 21:45:42,660 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-14 21:45:42,661 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-14 21:45:42,762 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:42,763 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:45:42.762588 duration_in_ms=102.773
2017-09-14 21:45:42,764 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:45:42.763580
2017-09-14 21:45:42,764 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-14 21:45:42,765 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-14 21:45:42,869 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:42,869 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:45:42.869401 duration_in_ms=105.821
2017-09-14 21:45:42,870 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:45:42.870302
2017-09-14 21:45:42,871 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-14 21:45:42,872 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-14 21:45:42,980 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:42,981 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:45:42.980553 duration_in_ms=110.25
2017-09-14 21:45:42,982 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:45:42.981631
2017-09-14 21:45:42,982 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-14 21:45:42,983 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-14 21:45:43,073 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:43,073 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:45:43.073389 duration_in_ms=91.757
2017-09-14 21:45:43,075 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:45:43.074492
2017-09-14 21:45:43,075 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-14 21:45:43,076 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-14 21:45:43,181 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:43,182 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:45:43.181560 duration_in_ms=107.067
2017-09-14 21:45:43,184 [salt.state       ][INFO    ][31829] Running state [glance] at time 21:45:43.184067
2017-09-14 21:45:43,185 [salt.state       ][INFO    ][31829] Executing state glusterfs.started for glance
2017-09-14 21:45:43,186 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:43,203 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:43,307 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:43,324 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:43,438 [salt.state       ][INFO    ][31829] Volume glance is already started
2017-09-14 21:45:43,439 [salt.state       ][INFO    ][31829] Completed state [glance] at time 21:45:43.438910 duration_in_ms=254.842
2017-09-14 21:45:43,441 [salt.state       ][INFO    ][31829] Running state [keystone-keys] at time 21:45:43.440926
2017-09-14 21:45:43,441 [salt.state       ][INFO    ][31829] Executing state glusterfs.created for keystone-keys
2017-09-14 21:45:43,442 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:43,459 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:43,562 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:43,580 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:43,688 [salt.state       ][INFO    ][31829] Volume keystone-keys already exists and is started.
2017-09-14 21:45:43,688 [salt.state       ][INFO    ][31829] Completed state [keystone-keys] at time 21:45:43.688169 duration_in_ms=247.232
2017-09-14 21:45:43,695 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:45:43.695307
2017-09-14 21:45:43,696 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-14 21:45:43,697 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-14 21:45:43,806 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:43,807 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:45:43.806474 duration_in_ms=111.166
2017-09-14 21:45:43,808 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:45:43.807551
2017-09-14 21:45:43,808 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-14 21:45:43,809 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-14 21:45:43,914 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:43,915 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:45:43.914755 duration_in_ms=107.203
2017-09-14 21:45:43,916 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:45:43.915818
2017-09-14 21:45:43,916 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-14 21:45:43,917 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-14 21:45:44,017 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:44,018 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:45:44.017933 duration_in_ms=102.114
2017-09-14 21:45:44,019 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:45:44.019023
2017-09-14 21:45:44,020 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-14 21:45:44,021 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-14 21:45:44,126 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:44,127 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:45:44.126740 duration_in_ms=107.717
2017-09-14 21:45:44,128 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:45:44.127834
2017-09-14 21:45:44,128 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-14 21:45:44,129 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-14 21:45:44,236 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:44,236 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:45:44.236327 duration_in_ms=108.492
2017-09-14 21:45:44,239 [salt.state       ][INFO    ][31829] Running state [keystone-keys] at time 21:45:44.238821
2017-09-14 21:45:44,239 [salt.state       ][INFO    ][31829] Executing state glusterfs.started for keystone-keys
2017-09-14 21:45:44,240 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:44,257 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:44,366 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:44,381 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:44,496 [salt.state       ][INFO    ][31829] Volume keystone-keys is already started
2017-09-14 21:45:44,497 [salt.state       ][INFO    ][31829] Completed state [keystone-keys] at time 21:45:44.496400 duration_in_ms=257.578
2017-09-14 21:45:44,499 [salt.state       ][INFO    ][31829] Running state [nova_instances] at time 21:45:44.499139
2017-09-14 21:45:44,500 [salt.state       ][INFO    ][31829] Executing state glusterfs.created for nova_instances
2017-09-14 21:45:44,501 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:44,520 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:44,627 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:44,642 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:44,752 [salt.state       ][INFO    ][31829] Volume nova_instances already exists and is started.
2017-09-14 21:45:44,752 [salt.state       ][INFO    ][31829] Completed state [nova_instances] at time 21:45:44.752289 duration_in_ms=253.15
2017-09-14 21:45:44,759 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:45:44.759366
2017-09-14 21:45:44,760 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-14 21:45:44,761 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-14 21:45:44,866 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:44,866 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:45:44.866077 duration_in_ms=106.71
2017-09-14 21:45:44,867 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 21:45:44.867091
2017-09-14 21:45:44,868 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-09-14 21:45:44,869 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-14 21:45:44,976 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:44,976 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 21:45:44.976085 duration_in_ms=108.993
2017-09-14 21:45:44,977 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 21:45:44.977169
2017-09-14 21:45:44,978 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-09-14 21:45:44,979 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-14 21:45:45,078 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:45,079 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 21:45:45.078712 duration_in_ms=101.541
2017-09-14 21:45:45,080 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 21:45:45.079795
2017-09-14 21:45:45,080 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-09-14 21:45:45,081 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-09-14 21:45:45,185 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:45,186 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 21:45:45.185503 duration_in_ms=105.708
2017-09-14 21:45:45,187 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:45:45.186586
2017-09-14 21:45:45,187 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-14 21:45:45,188 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-14 21:45:45,292 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:45,293 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:45:45.292592 duration_in_ms=106.005
2017-09-14 21:45:45,295 [salt.state       ][INFO    ][31829] Running state [nova_instances] at time 21:45:45.295088
2017-09-14 21:45:45,296 [salt.state       ][INFO    ][31829] Executing state glusterfs.started for nova_instances
2017-09-14 21:45:45,297 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:45,314 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:45,423 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:45,441 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:45,551 [salt.state       ][INFO    ][31829] Volume nova_instances is already started
2017-09-14 21:45:45,552 [salt.state       ][INFO    ][31829] Completed state [nova_instances] at time 21:45:45.551642 duration_in_ms=256.551
2017-09-14 21:45:45,554 [salt.state       ][INFO    ][31829] Running state [keystone-credential-keys] at time 21:45:45.553793
2017-09-14 21:45:45,554 [salt.state       ][INFO    ][31829] Executing state glusterfs.created for keystone-credential-keys
2017-09-14 21:45:45,555 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:45,574 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:45,682 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:45,700 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:45,814 [salt.state       ][INFO    ][31829] Volume keystone-credential-keys already exists and is started.
2017-09-14 21:45:45,815 [salt.state       ][INFO    ][31829] Completed state [keystone-credential-keys] at time 21:45:45.814619 duration_in_ms=260.825
2017-09-14 21:45:45,822 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:45:45.822157
2017-09-14 21:45:45,823 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-14 21:45:45,824 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-14 21:45:45,917 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:45,917 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:45:45.917315 duration_in_ms=95.157
2017-09-14 21:45:45,918 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:45:45.918330
2017-09-14 21:45:45,919 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-14 21:45:45,920 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-14 21:45:46,023 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:46,023 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:45:46.022962 duration_in_ms=104.631
2017-09-14 21:45:46,024 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:45:46.024038
2017-09-14 21:45:46,025 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-14 21:45:46,026 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-14 21:45:46,131 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:46,131 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:45:46.131047 duration_in_ms=107.009
2017-09-14 21:45:46,132 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:45:46.132137
2017-09-14 21:45:46,133 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-14 21:45:46,134 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-14 21:45:46,244 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:46,244 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:45:46.244052 duration_in_ms=111.915
2017-09-14 21:45:46,245 [salt.state       ][INFO    ][31829] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:45:46.245188
2017-09-14 21:45:46,246 [salt.state       ][INFO    ][31829] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-14 21:45:46,247 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-14 21:45:46,351 [salt.state       ][INFO    ][31829] unless execution succeeded
2017-09-14 21:45:46,352 [salt.state       ][INFO    ][31829] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:45:46.351614 duration_in_ms=106.425
2017-09-14 21:45:46,354 [salt.state       ][INFO    ][31829] Running state [keystone-credential-keys] at time 21:45:46.354153
2017-09-14 21:45:46,355 [salt.state       ][INFO    ][31829] Executing state glusterfs.started for keystone-credential-keys
2017-09-14 21:45:46,356 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:46,373 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:46,478 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --version' in directory '/root'
2017-09-14 21:45:46,496 [salt.loaded.int.module.cmdmod][INFO    ][31829] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 21:45:46,610 [salt.state       ][INFO    ][31829] Volume keystone-credential-keys is already started
2017-09-14 21:45:46,610 [salt.state       ][INFO    ][31829] Completed state [keystone-credential-keys] at time 21:45:46.609985 duration_in_ms=255.831
2017-09-14 21:45:46,614 [salt.minion      ][INFO    ][31829] Returning information for job: 20170914214539680256
2017-09-14 21:45:47,697 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command test.ping with jid 20170914214547690000
2017-09-14 21:45:47,718 [salt.minion      ][INFO    ][32232] Starting a new job with PID 32232
2017-09-14 21:45:47,775 [salt.minion      ][INFO    ][32232] Returning information for job: 20170914214547690000
2017-09-14 21:45:48,419 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command cmd.run with jid 20170914214548409954
2017-09-14 21:45:48,443 [salt.minion      ][INFO    ][32237] Starting a new job with PID 32237
2017-09-14 21:45:48,451 [salt.loaded.int.module.cmdmod][INFO    ][32237] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-14 21:45:48,667 [salt.minion      ][INFO    ][32237] Returning information for job: 20170914214548409954
2017-09-14 21:54:07,897 [salt.utils.schedule][INFO    ][22567] Running scheduled job: __mine_interval
2017-09-14 22:40:49,122 [salt.minion      ][INFO    ][22567] User sudo_ubuntu Executing command cp.push_dir with jid 20170914224049113087
2017-09-14 22:40:49,152 [salt.minion      ][INFO    ][520] Starting a new job with PID 520
