2017-10-27 19:36:27,341 [salt.cli.daemons ][WARNING ][2394] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 19:37:40,215 [salt.state       ][ERROR   ][3960] No contents found in top file
2017-10-27 19:39:35,691 [salt.utils.parsers][WARNING ][2394] Minion received a SIGTERM. Exiting.
2017-10-27 19:43:57,154 [salt.cli.daemons ][WARNING ][3442] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 19:46:05,446 [salt.loaded.int.module.cmdmod][ERROR   ][11650] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-10-27 19:46:05,447 [salt.loaded.int.module.cmdmod][ERROR   ][11650] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-10-27 19:46:05,447 [salt.loaded.int.module.cmdmod][ERROR   ][11650] retcode: 1
2017-10-27 19:46:05,448 [salt.state       ][ERROR   ][11650] {'pid': 16610, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-10-27 19:46:22,151 [py.warnings      ][WARNING ][16687] /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-10-27 19:47:41,497 [salt.loaded.int.module.cmdmod][ERROR   ][16687] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:41,504 [salt.loaded.int.module.cmdmod][ERROR   ][16687] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:47:46,497 [salt.loaded.int.module.cmdmod][ERROR   ][16687] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:46,499 [salt.loaded.int.module.cmdmod][ERROR   ][16687] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:47:51,621 [salt.loaded.int.module.cmdmod][ERROR   ][16687] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:51,621 [salt.loaded.int.module.cmdmod][ERROR   ][16687] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:47:56,710 [salt.loaded.int.module.cmdmod][ERROR   ][16687] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:56,711 [salt.loaded.int.module.cmdmod][ERROR   ][16687] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:48:00,738 [salt.loaded.int.module.cmdmod][ERROR   ][16687] 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-10-27 19:48:04,121 [salt.loaded.int.module.cmdmod][INFO    ][24219] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-27 19:48:04,137 [salt.loaded.int.module.cmdmod][INFO    ][24219] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:04,164 [salt.loaded.int.module.cmdmod][INFO    ][24219] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:04,184 [salt.utils.parsers][WARNING ][3442] Minion received a SIGTERM. Exiting.
2017-10-27 19:48:04,704 [salt.cli.daemons ][INFO    ][24305] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-odl-ha.local"
2017-10-27 19:48:05,669 [salt.minion      ][INFO    ][24305] Creating minion process manager
2017-10-27 19:48:05,670 [salt.cli.daemons ][WARNING ][24305] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 19:48:05,670 [salt.cli.daemons ][INFO    ][24305] The Salt Minion is starting up
2017-10-27 19:48:05,671 [salt.minion      ][INFO    ][24305] Minion is starting as user 'root'
2017-10-27 19:48:05,672 [salt.utils.event ][INFO    ][24305] Starting pull socket on /var/run/salt/minion/minion_event_0607a05f39_pull.ipc
2017-10-27 19:48:07,083 [salt.loaded.int.module.cmdmod][INFO    ][24305] Executing command ['date', '+%z'] in directory '/root'
2017-10-27 19:48:07,100 [salt.utils.schedule][INFO    ][24305] Updating job settings for scheduled job: __mine_interval
2017-10-27 19:48:07,105 [salt.minion      ][INFO    ][24305] Added mine.update to scheduler
2017-10-27 19:48:07,144 [salt.minion      ][INFO    ][24305] Minion is ready to receive requests!
2017-10-27 19:48:08,145 [salt.utils.schedule][INFO    ][24305] Running scheduled job: __mine_interval
2017-10-27 19:48:08,188 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171027194808181861
2017-10-27 19:48:08,212 [salt.minion      ][INFO    ][24427] Starting a new job with PID 24427
2017-10-27 19:48:10,861 [salt.state       ][INFO    ][24427] Loading fresh modules for state activity
2017-10-27 19:48:10,896 [salt.state       ][ERROR   ][24427] No contents found in top file
2017-10-27 19:48:10,898 [salt.utils.extmods][INFO    ][24427] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-27 19:48:10,906 [salt.utils.extmods][INFO    ][24427] Syncing beacons for environment 'base'
2017-10-27 19:48:10,907 [salt.utils.extmods][INFO    ][24427] Loading cache from salt://_beacons, for base)
2017-10-27 19:48:10,907 [salt.fileclient  ][INFO    ][24427] Caching directory '_beacons/' for environment 'base'
2017-10-27 19:48:10,950 [salt.utils.extmods][INFO    ][24427] Syncing modules for environment 'base'
2017-10-27 19:48:10,950 [salt.utils.extmods][INFO    ][24427] Loading cache from salt://_modules, for base)
2017-10-27 19:48:10,950 [salt.fileclient  ][INFO    ][24427] Caching directory '_modules/' for environment 'base'
2017-10-27 19:48:11,014 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-27 19:48:11,028 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-27 19:48:11,048 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-27 19:48:11,071 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-27 19:48:11,083 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-27 19:48:11,095 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-27 19:48:11,115 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-27 19:48:11,139 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-27 19:48:11,151 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-27 19:48:11,163 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-27 19:48:11,181 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-27 19:48:11,198 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-27 19:48:11,212 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-27 19:48:11,227 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-27 19:48:11,240 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-27 19:48:11,256 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-27 19:48:11,268 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-27 19:48:11,280 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-27 19:48:11,290 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-27 19:48:11,303 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-27 19:48:11,320 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-27 19:48:11,331 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-27 19:48:11,343 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-27 19:48:11,359 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-27 19:48:11,377 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-27 19:48:11,392 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-27 19:48:11,407 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-27 19:48:11,431 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-27 19:48:11,446 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-27 19:48:11,460 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-27 19:48:11,472 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-27 19:48:11,485 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-27 19:48:11,492 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-27 19:48:11,492 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-27 19:48:11,493 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-27 19:48:11,494 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-27 19:48:11,495 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-27 19:48:11,496 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-27 19:48:11,497 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-27 19:48:11,497 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-27 19:48:11,498 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-27 19:48:11,499 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-27 19:48:11,500 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-27 19:48:11,501 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-27 19:48:11,502 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-27 19:48:11,503 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-27 19:48:11,504 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-27 19:48:11,505 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-27 19:48:11,505 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-27 19:48:11,506 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-27 19:48:11,507 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-27 19:48:11,508 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-27 19:48:11,509 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-27 19:48:11,509 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-27 19:48:11,511 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-27 19:48:11,512 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-27 19:48:11,512 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-27 19:48:11,513 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-27 19:48:11,514 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-27 19:48:11,515 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-27 19:48:11,516 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-27 19:48:11,517 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-27 19:48:11,517 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-27 19:48:11,518 [salt.utils.extmods][INFO    ][24427] 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-10-27 19:48:11,519 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-27 19:48:11,519 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-27 19:48:11,530 [salt.utils.extmods][INFO    ][24427] Syncing states for environment 'base'
2017-10-27 19:48:11,530 [salt.utils.extmods][INFO    ][24427] Loading cache from salt://_states, for base)
2017-10-27 19:48:11,530 [salt.fileclient  ][INFO    ][24427] Caching directory '_states/' for environment 'base'
2017-10-27 19:48:11,575 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-27 19:48:11,591 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-27 19:48:11,603 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-27 19:48:11,617 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-27 19:48:11,631 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-27 19:48:11,817 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-27 19:48:11,835 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-27 19:48:11,856 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-27 19:48:11,872 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-27 19:48:11,888 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-27 19:48:11,900 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-27 19:48:11,915 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-27 19:48:11,931 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-27 19:48:11,946 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-27 19:48:11,960 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-27 19:48:11,973 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-27 19:48:11,987 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-27 19:48:12,003 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-27 19:48:12,017 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-27 19:48:12,033 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-27 19:48:12,046 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-27 19:48:12,060 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-27 19:48:12,073 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-27 19:48:12,092 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-27 19:48:12,107 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-27 19:48:12,120 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-27 19:48:12,142 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-27 19:48:12,158 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-27 19:48:12,172 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-27 19:48:12,179 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-27 19:48:12,180 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-27 19:48:12,180 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-27 19:48:12,181 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-27 19:48:12,182 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-27 19:48:12,182 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-27 19:48:12,183 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-27 19:48:12,183 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-27 19:48:12,183 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-27 19:48:12,184 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-27 19:48:12,184 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-27 19:48:12,184 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-27 19:48:12,184 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-27 19:48:12,185 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-27 19:48:12,185 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-27 19:48:12,185 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-27 19:48:12,186 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-27 19:48:12,186 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-27 19:48:12,187 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-27 19:48:12,187 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-27 19:48:12,187 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-27 19:48:12,187 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-27 19:48:12,188 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-27 19:48:12,188 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-27 19:48:12,188 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-27 19:48:12,189 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-27 19:48:12,189 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-27 19:48:12,189 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-27 19:48:12,190 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-27 19:48:12,190 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-27 19:48:12,194 [salt.utils.extmods][INFO    ][24427] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-27 19:48:12,205 [salt.utils.extmods][INFO    ][24427] Syncing sdb for environment 'base'
2017-10-27 19:48:12,205 [salt.utils.extmods][INFO    ][24427] Loading cache from salt://_sdb, for base)
2017-10-27 19:48:12,206 [salt.fileclient  ][INFO    ][24427] Caching directory '_sdb/' for environment 'base'
2017-10-27 19:48:12,256 [salt.utils.extmods][INFO    ][24427] Syncing grains for environment 'base'
2017-10-27 19:48:12,256 [salt.utils.extmods][INFO    ][24427] Loading cache from salt://_grains, for base)
2017-10-27 19:48:12,256 [salt.fileclient  ][INFO    ][24427] Caching directory '_grains/' for environment 'base'
2017-10-27 19:48:12,302 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-27 19:48:12,314 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-27 19:48:12,327 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-27 19:48:12,339 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-27 19:48:12,364 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-27 19:48:12,380 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-27 19:48:12,399 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-27 19:48:12,411 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-27 19:48:12,423 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-27 19:48:12,435 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-27 19:48:12,452 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-27 19:48:12,466 [salt.fileclient  ][INFO    ][24427] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-27 19:48:12,473 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-27 19:48:12,474 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-27 19:48:12,474 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-27 19:48:12,475 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-27 19:48:12,475 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-27 19:48:12,476 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-27 19:48:12,476 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-27 19:48:12,476 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-27 19:48:12,477 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-27 19:48:12,477 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-27 19:48:12,478 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-27 19:48:12,479 [salt.utils.extmods][INFO    ][24427] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-27 19:48:12,482 [salt.utils.extmods][INFO    ][24427] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-27 19:48:12,485 [salt.utils.extmods][INFO    ][24427] Syncing renderers for environment 'base'
2017-10-27 19:48:12,485 [salt.utils.extmods][INFO    ][24427] Loading cache from salt://_renderers, for base)
2017-10-27 19:48:12,485 [salt.fileclient  ][INFO    ][24427] Caching directory '_renderers/' for environment 'base'
2017-10-27 19:48:12,531 [salt.utils.extmods][INFO    ][24427] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-27 19:48:12,534 [salt.utils.extmods][INFO    ][24427] Syncing returners for environment 'base'
2017-10-27 19:48:12,534 [salt.utils.extmods][INFO    ][24427] Loading cache from salt://_returners, for base)
2017-10-27 19:48:12,534 [salt.fileclient  ][INFO    ][24427] Caching directory '_returners/' for environment 'base'
2017-10-27 19:48:12,571 [salt.utils.extmods][INFO    ][24427] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-27 19:48:12,573 [salt.utils.extmods][INFO    ][24427] Syncing output for environment 'base'
2017-10-27 19:48:12,574 [salt.utils.extmods][INFO    ][24427] Loading cache from salt://_output, for base)
2017-10-27 19:48:12,574 [salt.fileclient  ][INFO    ][24427] Caching directory '_output/' for environment 'base'
2017-10-27 19:48:12,613 [salt.utils.extmods][INFO    ][24427] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-27 19:48:12,616 [salt.utils.extmods][INFO    ][24427] Syncing utils for environment 'base'
2017-10-27 19:48:12,616 [salt.utils.extmods][INFO    ][24427] Loading cache from salt://_utils, for base)
2017-10-27 19:48:12,616 [salt.fileclient  ][INFO    ][24427] Caching directory '_utils/' for environment 'base'
2017-10-27 19:48:12,651 [salt.utils.extmods][INFO    ][24427] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-27 19:48:12,654 [salt.utils.extmods][INFO    ][24427] Syncing log_handlers for environment 'base'
2017-10-27 19:48:12,655 [salt.utils.extmods][INFO    ][24427] Loading cache from salt://_log_handlers, for base)
2017-10-27 19:48:12,655 [salt.fileclient  ][INFO    ][24427] Caching directory '_log_handlers/' for environment 'base'
2017-10-27 19:48:12,692 [salt.utils.extmods][INFO    ][24427] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-27 19:48:12,695 [salt.utils.extmods][INFO    ][24427] Syncing proxy for environment 'base'
2017-10-27 19:48:12,696 [salt.utils.extmods][INFO    ][24427] Loading cache from salt://_proxy, for base)
2017-10-27 19:48:12,696 [salt.fileclient  ][INFO    ][24427] Caching directory '_proxy/' for environment 'base'
2017-10-27 19:48:12,734 [salt.utils.extmods][INFO    ][24427] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-27 19:48:12,741 [salt.utils.extmods][INFO    ][24427] Syncing engines for environment 'base'
2017-10-27 19:48:12,741 [salt.utils.extmods][INFO    ][24427] Loading cache from salt://_engines, for base)
2017-10-27 19:48:12,742 [salt.fileclient  ][INFO    ][24427] Caching directory '_engines/' for environment 'base'
2017-10-27 19:48:12,787 [salt.minion      ][INFO    ][24427] Returning information for job: 20171027194808181861
2017-10-27 19:48:13,664 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command state.sls with jid 20171027194813533269
2017-10-27 19:48:13,683 [salt.minion      ][INFO    ][24507] Starting a new job with PID 24507
2017-10-27 19:48:14,311 [salt.state       ][INFO    ][24507] Loading fresh modules for state activity
2017-10-27 19:48:14,347 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-27 19:48:14,379 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-27 19:48:14,428 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:14,640 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-27 19:48:14,664 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-27 19:48:14,707 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:14,785 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 19:48:14,816 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:14,885 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 19:48:14,920 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 19:48:14,939 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:48:14,964 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 19:48:14,984 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 19:48:15,020 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 19:48:15,056 [py.warnings      ][WARNING ][24507] /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-10-27 19:48:15,057 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 19:48:15,389 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 19:48:15,416 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 19:48:15,432 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 19:48:15,457 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 19:48:15,529 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 19:48:15,574 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 19:48:15,651 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-27 19:48:15,679 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:15,753 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 19:48:15,784 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:15,876 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 19:48:15,903 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 19:48:15,921 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:48:15,950 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 19:48:15,967 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 19:48:16,011 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 19:48:16,040 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 19:48:16,380 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 19:48:16,412 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 19:48:16,431 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 19:48:16,452 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 19:48:16,525 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 19:48:16,584 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 19:48:16,673 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-27 19:48:16,759 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:17,180 [salt.state       ][INFO    ][24507] Running state [salt-minion] at time 19:48:17.179446
2017-10-27 19:48:17,180 [salt.state       ][INFO    ][24507] Executing state pkg.installed for salt-minion
2017-10-27 19:48:17,181 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 19:48:17,529 [salt.state       ][INFO    ][24507] Package salt-minion is already installed
2017-10-27 19:48:17,529 [salt.state       ][INFO    ][24507] Completed state [salt-minion] at time 19:48:17.529424 duration_in_ms=349.977
2017-10-27 19:48:17,530 [salt.state       ][INFO    ][24507] Running state [salt_minion_dependency_packages] at time 19:48:17.529711
2017-10-27 19:48:17,530 [salt.state       ][INFO    ][24507] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-27 19:48:17,534 [salt.state       ][INFO    ][24507] All specified packages are already installed
2017-10-27 19:48:17,534 [salt.state       ][INFO    ][24507] Completed state [salt_minion_dependency_packages] at time 19:48:17.534405 duration_in_ms=4.695
2017-10-27 19:48:17,536 [salt.state       ][INFO    ][24507] Running state [/etc/salt/minion.d/minion.conf] at time 19:48:17.536010
2017-10-27 19:48:17,536 [salt.state       ][INFO    ][24507] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-27 19:48:17,560 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-27 19:48:17,636 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:17,702 [salt.fileclient  ][INFO    ][24507] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:17,763 [salt.state       ][INFO    ][24507] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-27 19:48:17,763 [salt.state       ][INFO    ][24507] Completed state [/etc/salt/minion.d/minion.conf] at time 19:48:17.762847 duration_in_ms=226.837
2017-10-27 19:48:17,763 [salt.state       ][INFO    ][24507] Running state [/etc/salt/minion.d/_virt.conf] at time 19:48:17.763270
2017-10-27 19:48:17,764 [salt.state       ][INFO    ][24507] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-27 19:48:17,764 [salt.state       ][INFO    ][24507] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-27 19:48:17,764 [salt.state       ][INFO    ][24507] Completed state [/etc/salt/minion.d/_virt.conf] at time 19:48:17.764312 duration_in_ms=1.042
2017-10-27 19:48:17,766 [salt.state       ][INFO    ][24507] Running state [salt-minion] at time 19:48:17.766043
2017-10-27 19:48:17,766 [salt.state       ][INFO    ][24507] Executing state service.running for salt-minion
2017-10-27 19:48:17,767 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-27 19:48:17,800 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:17,820 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:17,837 [salt.state       ][INFO    ][24507] The service salt-minion is already running
2017-10-27 19:48:17,838 [salt.state       ][INFO    ][24507] Completed state [salt-minion] at time 19:48:17.838181 duration_in_ms=72.137
2017-10-27 19:48:17,844 [salt.state       ][INFO    ][24507] Running state [/etc/salt/grains.d] at time 19:48:17.843631
2017-10-27 19:48:17,844 [salt.state       ][INFO    ][24507] Executing state file.directory for /etc/salt/grains.d
2017-10-27 19:48:17,845 [salt.state       ][INFO    ][24507] Directory /etc/salt/grains.d is in the correct state
2017-10-27 19:48:17,845 [salt.state       ][INFO    ][24507] Completed state [/etc/salt/grains.d] at time 19:48:17.845259 duration_in_ms=1.628
2017-10-27 19:48:17,847 [salt.state       ][INFO    ][24507] Running state [/etc/salt/grains] at time 19:48:17.846465
2017-10-27 19:48:17,847 [salt.state       ][INFO    ][24507] Executing state file.managed for /etc/salt/grains
2017-10-27 19:48:17,847 [salt.state       ][INFO    ][24507] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-27 19:48:17,848 [salt.state       ][INFO    ][24507] Completed state [/etc/salt/grains] at time 19:48:17.847637 duration_in_ms=1.171
2017-10-27 19:48:17,848 [salt.state       ][INFO    ][24507] Running state [/etc/salt/grains.d/placeholder] at time 19:48:17.848246
2017-10-27 19:48:17,849 [salt.state       ][INFO    ][24507] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-27 19:48:17,849 [salt.state       ][INFO    ][24507] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-27 19:48:17,849 [salt.state       ][INFO    ][24507] Completed state [/etc/salt/grains.d/placeholder] at time 19:48:17.849351 duration_in_ms=1.104
2017-10-27 19:48:17,851 [salt.state       ][INFO    ][24507] Running state [/etc/salt/grains.d/sphinx] at time 19:48:17.850867
2017-10-27 19:48:17,851 [salt.state       ][INFO    ][24507] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-27 19:48:17,853 [salt.state       ][INFO    ][24507] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.142
               - 192.168.11.252
-              - 192.168.122.1
         system:
           name: System
           param:

2017-10-27 19:48:17,853 [salt.state       ][INFO    ][24507] Completed state [/etc/salt/grains.d/sphinx] at time 19:48:17.853418 duration_in_ms=2.552
2017-10-27 19:48:17,855 [salt.state       ][INFO    ][24507] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.854833
2017-10-27 19:48:17,855 [salt.state       ][INFO    ][24507] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,855 [salt.state       ][INFO    ][24507] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,855 [salt.state       ][INFO    ][24507] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.855388 duration_in_ms=0.555
2017-10-27 19:48:17,856 [salt.state       ][INFO    ][24507] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.855544
2017-10-27 19:48:17,856 [salt.state       ][INFO    ][24507] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,856 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-10-27 19:48:17,954 [salt.state       ][INFO    ][24507] {'pid': 24610, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-27 19:48:17,955 [salt.state       ][INFO    ][24507] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.954786 duration_in_ms=99.241
2017-10-27 19:48:17,956 [salt.state       ][INFO    ][24507] Running state [/etc/salt/grains.d/dns_records] at time 19:48:17.955948
2017-10-27 19:48:17,957 [salt.state       ][INFO    ][24507] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-27 19:48:17,959 [salt.state       ][INFO    ][24507] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-27 19:48:17,959 [salt.state       ][INFO    ][24507] Completed state [/etc/salt/grains.d/dns_records] at time 19:48:17.959275 duration_in_ms=3.326
2017-10-27 19:48:17,962 [salt.state       ][INFO    ][24507] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.961510
2017-10-27 19:48:17,962 [salt.state       ][INFO    ][24507] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,963 [salt.state       ][INFO    ][24507] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,963 [salt.state       ][INFO    ][24507] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.963205 duration_in_ms=1.695
2017-10-27 19:48:17,964 [salt.state       ][INFO    ][24507] Running state [/etc/salt/grains.d/salt] at time 19:48:17.964062
2017-10-27 19:48:17,965 [salt.state       ][INFO    ][24507] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-27 19:48:17,967 [salt.state       ][INFO    ][24507] File /etc/salt/grains.d/salt is in the correct state
2017-10-27 19:48:17,967 [salt.state       ][INFO    ][24507] Completed state [/etc/salt/grains.d/salt] at time 19:48:17.967003 duration_in_ms=2.94
2017-10-27 19:48:17,969 [salt.state       ][INFO    ][24507] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.968696
2017-10-27 19:48:17,970 [salt.state       ][INFO    ][24507] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,971 [salt.state       ][INFO    ][24507] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,971 [salt.state       ][INFO    ][24507] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.970857 duration_in_ms=2.161
2017-10-27 19:48:17,973 [salt.state       ][INFO    ][24507] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:17.972807
2017-10-27 19:48:17,973 [salt.state       ][INFO    ][24507] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 19:48:17,973 [salt.state       ][INFO    ][24507] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 19:48:17,973 [salt.state       ][INFO    ][24507] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:17.973403 duration_in_ms=0.595
2017-10-27 19:48:17,974 [salt.state       ][INFO    ][24507] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:17.973558
2017-10-27 19:48:17,974 [salt.state       ][INFO    ][24507] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 19:48:17,975 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-10-27 19:48:17,990 [salt.state       ][INFO    ][24507] {'pid': 24612, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-27 19:48:17,991 [salt.state       ][INFO    ][24507] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:17.990563 duration_in_ms=17.003
2017-10-27 19:48:17,992 [salt.state       ][INFO    ][24507] Running state [mine.update] at time 19:48:17.992222
2017-10-27 19:48:17,993 [salt.state       ][INFO    ][24507] Executing state module.wait for mine.update
2017-10-27 19:48:17,993 [salt.state       ][INFO    ][24507] No changes made for mine.update
2017-10-27 19:48:17,995 [salt.state       ][INFO    ][24507] Completed state [mine.update] at time 19:48:17.994530 duration_in_ms=2.309
2017-10-27 19:48:17,995 [salt.state       ][INFO    ][24507] Running state [mine.update] at time 19:48:17.995002
2017-10-27 19:48:17,995 [salt.state       ][INFO    ][24507] Executing state module.mod_watch for mine.update
2017-10-27 19:48:18,529 [salt.state       ][INFO    ][24507] {'ret': True}
2017-10-27 19:48:18,530 [salt.state       ][INFO    ][24507] Completed state [mine.update] at time 19:48:18.529526 duration_in_ms=534.524
2017-10-27 19:48:18,530 [salt.state       ][INFO    ][24507] Running state [ca-certificates] at time 19:48:18.530347
2017-10-27 19:48:18,531 [salt.state       ][INFO    ][24507] Executing state pkg.installed for ca-certificates
2017-10-27 19:48:18,536 [salt.state       ][INFO    ][24507] Package ca-certificates is already installed
2017-10-27 19:48:18,536 [salt.state       ][INFO    ][24507] Completed state [ca-certificates] at time 19:48:18.535762 duration_in_ms=5.415
2017-10-27 19:48:18,537 [salt.state       ][INFO    ][24507] Running state [update-ca-certificates] at time 19:48:18.536502
2017-10-27 19:48:18,537 [salt.state       ][INFO    ][24507] Executing state cmd.wait for update-ca-certificates
2017-10-27 19:48:18,537 [salt.state       ][INFO    ][24507] No changes made for update-ca-certificates
2017-10-27 19:48:18,537 [salt.state       ][INFO    ][24507] Completed state [update-ca-certificates] at time 19:48:18.537171 duration_in_ms=0.669
2017-10-27 19:48:18,537 [salt.state       ][INFO    ][24507] Running state [libvirt-dev] at time 19:48:18.537386
2017-10-27 19:48:18,538 [salt.state       ][INFO    ][24507] Executing state pkg.installed for libvirt-dev
2017-10-27 19:48:18,543 [salt.state       ][INFO    ][24507] Package libvirt-dev is already installed
2017-10-27 19:48:18,544 [salt.state       ][INFO    ][24507] Completed state [libvirt-dev] at time 19:48:18.543170 duration_in_ms=5.784
2017-10-27 19:48:18,544 [salt.state       ][INFO    ][24507] Running state [pkg-config] at time 19:48:18.543697
2017-10-27 19:48:18,544 [salt.state       ][INFO    ][24507] Executing state pkg.installed for pkg-config
2017-10-27 19:48:18,547 [salt.state       ][INFO    ][24507] Package pkg-config is already installed
2017-10-27 19:48:18,548 [salt.state       ][INFO    ][24507] Completed state [pkg-config] at time 19:48:18.547640 duration_in_ms=3.943
2017-10-27 19:48:18,548 [salt.state       ][INFO    ][24507] Running state [virtng.init] at time 19:48:18.547836
2017-10-27 19:48:18,548 [salt.state       ][INFO    ][24507] Executing state module.run for virtng.init
2017-10-27 19:48:18,610 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command ['git', '--version'] in directory '/root'
2017-10-27 19:48:18,710 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:18,745 [salt.state       ][INFO    ][24507] unless execution succeeded
2017-10-27 19:48:18,745 [salt.state       ][INFO    ][24507] Completed state [virtng.init] at time 19:48:18.744816 duration_in_ms=196.979
2017-10-27 19:48:18,745 [salt.state       ][INFO    ][24507] Running state [virt.set_autostart] at time 19:48:18.745409
2017-10-27 19:48:18,747 [salt.state       ][INFO    ][24507] Executing state module.run for virt.set_autostart
2017-10-27 19:48:18,752 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:18,785 [salt.state       ][INFO    ][24507] unless execution succeeded
2017-10-27 19:48:18,787 [salt.state       ][INFO    ][24507] Completed state [virt.set_autostart] at time 19:48:18.787335 duration_in_ms=41.925
2017-10-27 19:48:18,788 [salt.state       ][INFO    ][24507] Running state [virtng.init] at time 19:48:18.787889
2017-10-27 19:48:18,788 [salt.state       ][INFO    ][24507] Executing state module.run for virtng.init
2017-10-27 19:48:18,795 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:18,828 [salt.state       ][INFO    ][24507] unless execution succeeded
2017-10-27 19:48:18,829 [salt.state       ][INFO    ][24507] Completed state [virtng.init] at time 19:48:18.828690 duration_in_ms=40.801
2017-10-27 19:48:18,829 [salt.state       ][INFO    ][24507] Running state [virt.set_autostart] at time 19:48:18.828950
2017-10-27 19:48:18,829 [salt.state       ][INFO    ][24507] Executing state module.run for virt.set_autostart
2017-10-27 19:48:18,836 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:18,872 [salt.state       ][INFO    ][24507] unless execution succeeded
2017-10-27 19:48:18,873 [salt.state       ][INFO    ][24507] Completed state [virt.set_autostart] at time 19:48:18.872861 duration_in_ms=43.909
2017-10-27 19:48:18,873 [salt.state       ][INFO    ][24507] Running state [virtng.init] at time 19:48:18.873421
2017-10-27 19:48:18,875 [salt.state       ][INFO    ][24507] Executing state module.run for virtng.init
2017-10-27 19:48:18,881 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:18,915 [salt.state       ][INFO    ][24507] unless execution succeeded
2017-10-27 19:48:18,915 [salt.state       ][INFO    ][24507] Completed state [virtng.init] at time 19:48:18.915041 duration_in_ms=41.619
2017-10-27 19:48:18,916 [salt.state       ][INFO    ][24507] Running state [virt.set_autostart] at time 19:48:18.915662
2017-10-27 19:48:18,916 [salt.state       ][INFO    ][24507] Executing state module.run for virt.set_autostart
2017-10-27 19:48:18,924 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:18,959 [salt.state       ][INFO    ][24507] unless execution succeeded
2017-10-27 19:48:18,959 [salt.state       ][INFO    ][24507] Completed state [virt.set_autostart] at time 19:48:18.958961 duration_in_ms=43.298
2017-10-27 19:48:18,960 [salt.state       ][INFO    ][24507] Running state [virtng.init] at time 19:48:18.959483
2017-10-27 19:48:18,960 [salt.state       ][INFO    ][24507] Executing state module.run for virtng.init
2017-10-27 19:48:18,968 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:19,005 [salt.state       ][INFO    ][24507] unless execution succeeded
2017-10-27 19:48:19,006 [salt.state       ][INFO    ][24507] Completed state [virtng.init] at time 19:48:19.005560 duration_in_ms=46.077
2017-10-27 19:48:19,007 [salt.state       ][INFO    ][24507] Running state [virt.set_autostart] at time 19:48:19.007033
2017-10-27 19:48:19,007 [salt.state       ][INFO    ][24507] Executing state module.run for virt.set_autostart
2017-10-27 19:48:19,014 [salt.loaded.int.module.cmdmod][INFO    ][24507] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:19,053 [salt.state       ][INFO    ][24507] unless execution succeeded
2017-10-27 19:48:19,053 [salt.state       ][INFO    ][24507] Completed state [virt.set_autostart] at time 19:48:19.053080 duration_in_ms=46.046
2017-10-27 19:48:19,061 [salt.minion      ][INFO    ][24507] Returning information for job: 20171027194813533269
2017-10-27 19:48:44,653 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command state.sls with jid 20171027194844647321
2017-10-27 19:48:44,680 [salt.minion      ][INFO    ][24658] Starting a new job with PID 24658
2017-10-27 19:48:47,349 [salt.state       ][INFO    ][24658] Loading fresh modules for state activity
2017-10-27 19:48:47,392 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-27 19:48:47,423 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-27 19:48:47,497 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:47,594 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-27 19:48:47,616 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-27 19:48:47,657 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:47,740 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 19:48:47,767 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:47,834 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 19:48:47,867 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 19:48:47,890 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:48:47,916 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 19:48:47,933 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 19:48:47,976 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 19:48:48,005 [py.warnings      ][WARNING ][24658] /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-10-27 19:48:48,005 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 19:48:48,337 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 19:48:48,361 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 19:48:48,376 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 19:48:48,395 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 19:48:48,461 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 19:48:48,515 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 19:48:48,613 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-27 19:48:48,649 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:48,730 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 19:48:48,759 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:48,826 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 19:48:48,856 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 19:48:48,879 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:48:48,903 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 19:48:48,932 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 19:48:48,968 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 19:48:48,1000 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 19:48:49,323 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 19:48:49,350 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 19:48:49,367 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 19:48:49,386 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 19:48:49,452 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 19:48:49,511 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 19:48:49,603 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-27 19:48:49,694 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:50,090 [salt.state       ][INFO    ][24658] Running state [salt-minion] at time 19:48:50.090276
2017-10-27 19:48:50,091 [salt.state       ][INFO    ][24658] Executing state pkg.installed for salt-minion
2017-10-27 19:48:50,091 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 19:48:50,417 [salt.state       ][INFO    ][24658] Package salt-minion is already installed
2017-10-27 19:48:50,418 [salt.state       ][INFO    ][24658] Completed state [salt-minion] at time 19:48:50.418065 duration_in_ms=327.789
2017-10-27 19:48:50,418 [salt.state       ][INFO    ][24658] Running state [salt_minion_dependency_packages] at time 19:48:50.418330
2017-10-27 19:48:50,419 [salt.state       ][INFO    ][24658] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-27 19:48:50,422 [salt.state       ][INFO    ][24658] All specified packages are already installed
2017-10-27 19:48:50,422 [salt.state       ][INFO    ][24658] Completed state [salt_minion_dependency_packages] at time 19:48:50.422290 duration_in_ms=3.959
2017-10-27 19:48:50,424 [salt.state       ][INFO    ][24658] Running state [/etc/salt/minion.d/minion.conf] at time 19:48:50.424312
2017-10-27 19:48:50,425 [salt.state       ][INFO    ][24658] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-27 19:48:50,455 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-27 19:48:50,534 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:50,600 [salt.fileclient  ][INFO    ][24658] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:50,662 [salt.state       ][INFO    ][24658] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-27 19:48:50,662 [salt.state       ][INFO    ][24658] Completed state [/etc/salt/minion.d/minion.conf] at time 19:48:50.662190 duration_in_ms=237.876
2017-10-27 19:48:50,663 [salt.state       ][INFO    ][24658] Running state [/etc/salt/minion.d/_virt.conf] at time 19:48:50.663153
2017-10-27 19:48:50,664 [salt.state       ][INFO    ][24658] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-27 19:48:50,665 [salt.state       ][INFO    ][24658] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-27 19:48:50,666 [salt.state       ][INFO    ][24658] Completed state [/etc/salt/minion.d/_virt.conf] at time 19:48:50.665618 duration_in_ms=2.465
2017-10-27 19:48:50,670 [salt.state       ][INFO    ][24658] Running state [salt-minion] at time 19:48:50.670390
2017-10-27 19:48:50,671 [salt.state       ][INFO    ][24658] Executing state service.running for salt-minion
2017-10-27 19:48:50,671 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-27 19:48:50,704 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:50,720 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:50,741 [salt.state       ][INFO    ][24658] The service salt-minion is already running
2017-10-27 19:48:50,741 [salt.state       ][INFO    ][24658] Completed state [salt-minion] at time 19:48:50.741204 duration_in_ms=70.812
2017-10-27 19:48:50,745 [salt.state       ][INFO    ][24658] Running state [/etc/salt/grains.d] at time 19:48:50.745351
2017-10-27 19:48:50,748 [salt.state       ][INFO    ][24658] Executing state file.directory for /etc/salt/grains.d
2017-10-27 19:48:50,749 [salt.state       ][INFO    ][24658] Directory /etc/salt/grains.d is in the correct state
2017-10-27 19:48:50,749 [salt.state       ][INFO    ][24658] Completed state [/etc/salt/grains.d] at time 19:48:50.749116 duration_in_ms=3.766
2017-10-27 19:48:50,751 [salt.state       ][INFO    ][24658] Running state [/etc/salt/grains] at time 19:48:50.750532
2017-10-27 19:48:50,751 [salt.state       ][INFO    ][24658] Executing state file.managed for /etc/salt/grains
2017-10-27 19:48:50,751 [salt.state       ][INFO    ][24658] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-27 19:48:50,752 [salt.state       ][INFO    ][24658] Completed state [/etc/salt/grains] at time 19:48:50.751589 duration_in_ms=1.057
2017-10-27 19:48:50,752 [salt.state       ][INFO    ][24658] Running state [/etc/salt/grains.d/placeholder] at time 19:48:50.752127
2017-10-27 19:48:50,752 [salt.state       ][INFO    ][24658] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-27 19:48:50,753 [salt.state       ][INFO    ][24658] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-27 19:48:50,753 [salt.state       ][INFO    ][24658] Completed state [/etc/salt/grains.d/placeholder] at time 19:48:50.753132 duration_in_ms=1.005
2017-10-27 19:48:50,755 [salt.state       ][INFO    ][24658] Running state [/etc/salt/grains.d/sphinx] at time 19:48:50.754837
2017-10-27 19:48:50,755 [salt.state       ][INFO    ][24658] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-27 19:48:50,756 [salt.state       ][INFO    ][24658] File /etc/salt/grains.d/sphinx is in the correct state
2017-10-27 19:48:50,757 [salt.state       ][INFO    ][24658] Completed state [/etc/salt/grains.d/sphinx] at time 19:48:50.756646 duration_in_ms=1.809
2017-10-27 19:48:50,758 [salt.state       ][INFO    ][24658] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.757473
2017-10-27 19:48:50,759 [salt.state       ][INFO    ][24658] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:50,759 [salt.state       ][INFO    ][24658] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:50,759 [salt.state       ][INFO    ][24658] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.759461 duration_in_ms=1.988
2017-10-27 19:48:50,760 [salt.state       ][INFO    ][24658] Running state [/etc/salt/grains.d/dns_records] at time 19:48:50.759826
2017-10-27 19:48:50,760 [salt.state       ][INFO    ][24658] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-27 19:48:50,761 [salt.state       ][INFO    ][24658] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-27 19:48:50,761 [salt.state       ][INFO    ][24658] Completed state [/etc/salt/grains.d/dns_records] at time 19:48:50.760834 duration_in_ms=1.007
2017-10-27 19:48:50,762 [salt.state       ][INFO    ][24658] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.761598
2017-10-27 19:48:50,762 [salt.state       ][INFO    ][24658] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:50,762 [salt.state       ][INFO    ][24658] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:50,762 [salt.state       ][INFO    ][24658] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.762272 duration_in_ms=0.674
2017-10-27 19:48:50,763 [salt.state       ][INFO    ][24658] Running state [/etc/salt/grains.d/salt] at time 19:48:50.762648
2017-10-27 19:48:50,763 [salt.state       ][INFO    ][24658] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-27 19:48:50,764 [salt.state       ][INFO    ][24658] File /etc/salt/grains.d/salt is in the correct state
2017-10-27 19:48:50,764 [salt.state       ][INFO    ][24658] Completed state [/etc/salt/grains.d/salt] at time 19:48:50.763667 duration_in_ms=1.019
2017-10-27 19:48:50,764 [salt.state       ][INFO    ][24658] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.764392
2017-10-27 19:48:50,765 [salt.state       ][INFO    ][24658] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:50,765 [salt.state       ][INFO    ][24658] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:50,765 [salt.state       ][INFO    ][24658] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.764955 duration_in_ms=0.564
2017-10-27 19:48:50,768 [salt.state       ][INFO    ][24658] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:50.767494
2017-10-27 19:48:50,768 [salt.state       ][INFO    ][24658] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 19:48:50,768 [salt.state       ][INFO    ][24658] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 19:48:50,768 [salt.state       ][INFO    ][24658] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:50.768116 duration_in_ms=0.622
2017-10-27 19:48:50,769 [salt.state       ][INFO    ][24658] Running state [mine.update] at time 19:48:50.768689
2017-10-27 19:48:50,769 [salt.state       ][INFO    ][24658] Executing state module.wait for mine.update
2017-10-27 19:48:50,769 [salt.state       ][INFO    ][24658] No changes made for mine.update
2017-10-27 19:48:50,769 [salt.state       ][INFO    ][24658] Completed state [mine.update] at time 19:48:50.769226 duration_in_ms=0.536
2017-10-27 19:48:50,769 [salt.state       ][INFO    ][24658] Running state [ca-certificates] at time 19:48:50.769402
2017-10-27 19:48:50,770 [salt.state       ][INFO    ][24658] Executing state pkg.installed for ca-certificates
2017-10-27 19:48:50,775 [salt.state       ][INFO    ][24658] Package ca-certificates is already installed
2017-10-27 19:48:50,775 [salt.state       ][INFO    ][24658] Completed state [ca-certificates] at time 19:48:50.775390 duration_in_ms=5.987
2017-10-27 19:48:50,776 [salt.state       ][INFO    ][24658] Running state [update-ca-certificates] at time 19:48:50.776323
2017-10-27 19:48:50,777 [salt.state       ][INFO    ][24658] Executing state cmd.wait for update-ca-certificates
2017-10-27 19:48:50,777 [salt.state       ][INFO    ][24658] No changes made for update-ca-certificates
2017-10-27 19:48:50,777 [salt.state       ][INFO    ][24658] Completed state [update-ca-certificates] at time 19:48:50.776890 duration_in_ms=0.567
2017-10-27 19:48:50,777 [salt.state       ][INFO    ][24658] Running state [libvirt-dev] at time 19:48:50.777062
2017-10-27 19:48:50,777 [salt.state       ][INFO    ][24658] Executing state pkg.installed for libvirt-dev
2017-10-27 19:48:50,781 [salt.state       ][INFO    ][24658] Package libvirt-dev is already installed
2017-10-27 19:48:50,781 [salt.state       ][INFO    ][24658] Completed state [libvirt-dev] at time 19:48:50.781334 duration_in_ms=4.272
2017-10-27 19:48:50,782 [salt.state       ][INFO    ][24658] Running state [pkg-config] at time 19:48:50.781530
2017-10-27 19:48:50,782 [salt.state       ][INFO    ][24658] Executing state pkg.installed for pkg-config
2017-10-27 19:48:50,786 [salt.state       ][INFO    ][24658] Package pkg-config is already installed
2017-10-27 19:48:50,787 [salt.state       ][INFO    ][24658] Completed state [pkg-config] at time 19:48:50.786543 duration_in_ms=5.013
2017-10-27 19:48:50,787 [salt.state       ][INFO    ][24658] Running state [virtng.init] at time 19:48:50.786739
2017-10-27 19:48:50,787 [salt.state       ][INFO    ][24658] Executing state module.run for virtng.init
2017-10-27 19:48:50,835 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command ['git', '--version'] in directory '/root'
2017-10-27 19:48:50,937 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:50,965 [salt.state       ][INFO    ][24658] unless execution succeeded
2017-10-27 19:48:50,966 [salt.state       ][INFO    ][24658] Completed state [virtng.init] at time 19:48:50.965660 duration_in_ms=178.917
2017-10-27 19:48:50,966 [salt.state       ][INFO    ][24658] Running state [virt.set_autostart] at time 19:48:50.966258
2017-10-27 19:48:50,967 [salt.state       ][INFO    ][24658] Executing state module.run for virt.set_autostart
2017-10-27 19:48:50,972 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:51,013 [salt.state       ][INFO    ][24658] unless execution succeeded
2017-10-27 19:48:51,013 [salt.state       ][INFO    ][24658] Completed state [virt.set_autostart] at time 19:48:51.013331 duration_in_ms=47.072
2017-10-27 19:48:51,015 [salt.state       ][INFO    ][24658] Running state [virtng.init] at time 19:48:51.014473
2017-10-27 19:48:51,015 [salt.state       ][INFO    ][24658] Executing state module.run for virtng.init
2017-10-27 19:48:51,025 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:51,064 [salt.state       ][INFO    ][24658] unless execution succeeded
2017-10-27 19:48:51,064 [salt.state       ][INFO    ][24658] Completed state [virtng.init] at time 19:48:51.064135 duration_in_ms=49.662
2017-10-27 19:48:51,064 [salt.state       ][INFO    ][24658] Running state [virt.set_autostart] at time 19:48:51.064409
2017-10-27 19:48:51,065 [salt.state       ][INFO    ][24658] Executing state module.run for virt.set_autostart
2017-10-27 19:48:51,072 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:51,104 [salt.state       ][INFO    ][24658] unless execution succeeded
2017-10-27 19:48:51,104 [salt.state       ][INFO    ][24658] Completed state [virt.set_autostart] at time 19:48:51.104234 duration_in_ms=39.823
2017-10-27 19:48:51,105 [salt.state       ][INFO    ][24658] Running state [virtng.init] at time 19:48:51.104764
2017-10-27 19:48:51,105 [salt.state       ][INFO    ][24658] Executing state module.run for virtng.init
2017-10-27 19:48:51,111 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:51,149 [salt.state       ][INFO    ][24658] unless execution succeeded
2017-10-27 19:48:51,149 [salt.state       ][INFO    ][24658] Completed state [virtng.init] at time 19:48:51.148921 duration_in_ms=44.155
2017-10-27 19:48:51,150 [salt.state       ][INFO    ][24658] Running state [virt.set_autostart] at time 19:48:51.149448
2017-10-27 19:48:51,152 [salt.state       ][INFO    ][24658] Executing state module.run for virt.set_autostart
2017-10-27 19:48:51,160 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:51,197 [salt.state       ][INFO    ][24658] unless execution succeeded
2017-10-27 19:48:51,200 [salt.state       ][INFO    ][24658] Completed state [virt.set_autostart] at time 19:48:51.197586 duration_in_ms=48.138
2017-10-27 19:48:51,201 [salt.state       ][INFO    ][24658] Running state [virtng.init] at time 19:48:51.200573
2017-10-27 19:48:51,201 [salt.state       ][INFO    ][24658] Executing state module.run for virtng.init
2017-10-27 19:48:51,208 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:51,243 [salt.state       ][INFO    ][24658] unless execution succeeded
2017-10-27 19:48:51,243 [salt.state       ][INFO    ][24658] Completed state [virtng.init] at time 19:48:51.243134 duration_in_ms=42.561
2017-10-27 19:48:51,243 [salt.state       ][INFO    ][24658] Running state [virt.set_autostart] at time 19:48:51.243415
2017-10-27 19:48:51,244 [salt.state       ][INFO    ][24658] Executing state module.run for virt.set_autostart
2017-10-27 19:48:51,251 [salt.loaded.int.module.cmdmod][INFO    ][24658] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:51,281 [salt.state       ][INFO    ][24658] unless execution succeeded
2017-10-27 19:48:51,282 [salt.state       ][INFO    ][24658] Completed state [virt.set_autostart] at time 19:48:51.281979 duration_in_ms=38.564
2017-10-27 19:48:51,290 [salt.minion      ][INFO    ][24658] Returning information for job: 20171027194844647321
2017-10-27 19:49:11,305 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171027194911295492
2017-10-27 19:49:11,336 [salt.minion      ][INFO    ][24747] Starting a new job with PID 24747
2017-10-27 19:49:15,912 [salt.state       ][INFO    ][24747] Loading fresh modules for state activity
2017-10-27 19:49:15,956 [salt.state       ][ERROR   ][24747] No contents found in top file
2017-10-27 19:49:15,957 [salt.utils.extmods][INFO    ][24747] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-27 19:49:15,962 [salt.utils.extmods][INFO    ][24747] Syncing beacons for environment 'base'
2017-10-27 19:49:15,962 [salt.utils.extmods][INFO    ][24747] Loading cache from salt://_beacons, for base)
2017-10-27 19:49:15,963 [salt.fileclient  ][INFO    ][24747] Caching directory '_beacons/' for environment 'base'
2017-10-27 19:49:16,010 [salt.utils.extmods][INFO    ][24747] Syncing modules for environment 'base'
2017-10-27 19:49:16,010 [salt.utils.extmods][INFO    ][24747] Loading cache from salt://_modules, for base)
2017-10-27 19:49:16,010 [salt.fileclient  ][INFO    ][24747] Caching directory '_modules/' for environment 'base'
2017-10-27 19:49:16,515 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-27 19:49:16,546 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-27 19:49:16,572 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-27 19:49:16,595 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-27 19:49:16,608 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-27 19:49:16,638 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-27 19:49:16,653 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-27 19:49:16,672 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-27 19:49:16,683 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-27 19:49:16,695 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-27 19:49:16,716 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-27 19:49:16,827 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-27 19:49:16,843 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-27 19:49:16,867 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-27 19:49:16,881 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-27 19:49:16,892 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-27 19:49:16,903 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-27 19:49:16,924 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-27 19:49:16,961 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-27 19:49:16,979 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-27 19:49:17,015 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-27 19:49:17,063 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-27 19:49:17,084 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-27 19:49:17,100 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-27 19:49:17,131 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-27 19:49:17,170 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-27 19:49:17,186 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-27 19:49:17,229 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-27 19:49:17,272 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-27 19:49:17,294 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-27 19:49:17,315 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-27 19:49:17,348 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-27 19:49:17,359 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-27 19:49:17,360 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-27 19:49:17,360 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-27 19:49:17,360 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-27 19:49:17,361 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-27 19:49:17,361 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-27 19:49:17,362 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-27 19:49:17,362 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-27 19:49:17,363 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-27 19:49:17,363 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-27 19:49:17,364 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-27 19:49:17,364 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-27 19:49:17,364 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-27 19:49:17,365 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-27 19:49:17,365 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-27 19:49:17,365 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-27 19:49:17,366 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-27 19:49:17,367 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-27 19:49:17,367 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-27 19:49:17,367 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-27 19:49:17,368 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-27 19:49:17,368 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-27 19:49:17,369 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-27 19:49:17,369 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-27 19:49:17,370 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-27 19:49:17,370 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-27 19:49:17,370 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-27 19:49:17,371 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-27 19:49:17,371 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-27 19:49:17,371 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-27 19:49:17,372 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-27 19:49:17,372 [salt.utils.extmods][INFO    ][24747] 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-10-27 19:49:17,373 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-27 19:49:17,373 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-27 19:49:17,385 [salt.utils.extmods][INFO    ][24747] Syncing states for environment 'base'
2017-10-27 19:49:17,386 [salt.utils.extmods][INFO    ][24747] Loading cache from salt://_states, for base)
2017-10-27 19:49:17,386 [salt.fileclient  ][INFO    ][24747] Caching directory '_states/' for environment 'base'
2017-10-27 19:49:17,491 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-27 19:49:17,523 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-27 19:49:17,552 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-27 19:49:17,591 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-27 19:49:17,614 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-27 19:49:17,635 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-27 19:49:17,656 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-27 19:49:17,686 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-27 19:49:17,745 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-27 19:49:17,781 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-27 19:49:17,810 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-27 19:49:17,830 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-27 19:49:17,852 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-27 19:49:17,874 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-27 19:49:17,920 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-27 19:49:17,956 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-27 19:49:17,980 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-27 19:49:17,998 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-27 19:49:18,011 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-27 19:49:18,031 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-27 19:49:18,059 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-27 19:49:18,081 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-27 19:49:18,100 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-27 19:49:18,145 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-27 19:49:18,199 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-27 19:49:18,304 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-27 19:49:18,361 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-27 19:49:18,375 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-27 19:49:18,396 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-27 19:49:18,406 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-27 19:49:18,407 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-27 19:49:18,407 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-27 19:49:18,408 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-27 19:49:18,408 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-27 19:49:18,409 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-27 19:49:18,409 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-27 19:49:18,409 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-27 19:49:18,410 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-27 19:49:18,410 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-27 19:49:18,410 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-27 19:49:18,411 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-27 19:49:18,411 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-27 19:49:18,411 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-27 19:49:18,412 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-27 19:49:18,412 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-27 19:49:18,412 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-27 19:49:18,413 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-27 19:49:18,413 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-27 19:49:18,413 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-27 19:49:18,414 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-27 19:49:18,414 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-27 19:49:18,414 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-27 19:49:18,414 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-27 19:49:18,415 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-27 19:49:18,415 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-27 19:49:18,416 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-27 19:49:18,416 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-27 19:49:18,417 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-27 19:49:18,417 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-27 19:49:18,420 [salt.utils.extmods][INFO    ][24747] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-27 19:49:18,424 [salt.utils.extmods][INFO    ][24747] Syncing sdb for environment 'base'
2017-10-27 19:49:18,424 [salt.utils.extmods][INFO    ][24747] Loading cache from salt://_sdb, for base)
2017-10-27 19:49:18,424 [salt.fileclient  ][INFO    ][24747] Caching directory '_sdb/' for environment 'base'
2017-10-27 19:49:18,526 [salt.utils.extmods][INFO    ][24747] Syncing grains for environment 'base'
2017-10-27 19:49:18,526 [salt.utils.extmods][INFO    ][24747] Loading cache from salt://_grains, for base)
2017-10-27 19:49:18,526 [salt.fileclient  ][INFO    ][24747] Caching directory '_grains/' for environment 'base'
2017-10-27 19:49:18,635 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-27 19:49:18,663 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-27 19:49:18,680 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-27 19:49:18,699 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-27 19:49:18,721 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-27 19:49:20,070 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-27 19:49:20,471 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-27 19:49:20,483 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-27 19:49:20,494 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-27 19:49:20,507 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-27 19:49:21,199 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-27 19:49:21,211 [salt.fileclient  ][INFO    ][24747] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-27 19:49:21,217 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-27 19:49:21,217 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-27 19:49:21,218 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-27 19:49:21,218 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-27 19:49:21,219 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-27 19:49:21,219 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-27 19:49:21,219 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-27 19:49:21,219 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-27 19:49:21,220 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-27 19:49:21,220 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-27 19:49:21,221 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-27 19:49:21,221 [salt.utils.extmods][INFO    ][24747] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-27 19:49:21,224 [salt.utils.extmods][INFO    ][24747] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-27 19:49:21,232 [salt.utils.extmods][INFO    ][24747] Syncing renderers for environment 'base'
2017-10-27 19:49:21,232 [salt.utils.extmods][INFO    ][24747] Loading cache from salt://_renderers, for base)
2017-10-27 19:49:21,232 [salt.fileclient  ][INFO    ][24747] Caching directory '_renderers/' for environment 'base'
2017-10-27 19:49:21,273 [salt.utils.extmods][INFO    ][24747] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-27 19:49:21,276 [salt.utils.extmods][INFO    ][24747] Syncing returners for environment 'base'
2017-10-27 19:49:21,277 [salt.utils.extmods][INFO    ][24747] Loading cache from salt://_returners, for base)
2017-10-27 19:49:21,277 [salt.fileclient  ][INFO    ][24747] Caching directory '_returners/' for environment 'base'
2017-10-27 19:49:21,315 [salt.utils.extmods][INFO    ][24747] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-27 19:49:21,319 [salt.utils.extmods][INFO    ][24747] Syncing output for environment 'base'
2017-10-27 19:49:21,319 [salt.utils.extmods][INFO    ][24747] Loading cache from salt://_output, for base)
2017-10-27 19:49:21,319 [salt.fileclient  ][INFO    ][24747] Caching directory '_output/' for environment 'base'
2017-10-27 19:49:21,359 [salt.utils.extmods][INFO    ][24747] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-27 19:49:21,363 [salt.utils.extmods][INFO    ][24747] Syncing utils for environment 'base'
2017-10-27 19:49:21,363 [salt.utils.extmods][INFO    ][24747] Loading cache from salt://_utils, for base)
2017-10-27 19:49:21,363 [salt.fileclient  ][INFO    ][24747] Caching directory '_utils/' for environment 'base'
2017-10-27 19:49:21,380 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027194921376556
2017-10-27 19:49:21,403 [salt.minion      ][INFO    ][24772] Starting a new job with PID 24772
2017-10-27 19:49:21,408 [salt.utils.extmods][INFO    ][24747] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-27 19:49:21,412 [salt.utils.extmods][INFO    ][24747] Syncing log_handlers for environment 'base'
2017-10-27 19:49:21,412 [salt.utils.extmods][INFO    ][24747] Loading cache from salt://_log_handlers, for base)
2017-10-27 19:49:21,412 [salt.fileclient  ][INFO    ][24747] Caching directory '_log_handlers/' for environment 'base'
2017-10-27 19:49:21,419 [salt.minion      ][INFO    ][24772] Returning information for job: 20171027194921376556
2017-10-27 19:49:21,456 [salt.utils.extmods][INFO    ][24747] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-27 19:49:21,462 [salt.utils.extmods][INFO    ][24747] Syncing proxy for environment 'base'
2017-10-27 19:49:21,462 [salt.utils.extmods][INFO    ][24747] Loading cache from salt://_proxy, for base)
2017-10-27 19:49:21,462 [salt.fileclient  ][INFO    ][24747] Caching directory '_proxy/' for environment 'base'
2017-10-27 19:49:21,499 [salt.utils.extmods][INFO    ][24747] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-27 19:49:21,503 [salt.utils.extmods][INFO    ][24747] Syncing engines for environment 'base'
2017-10-27 19:49:21,503 [salt.utils.extmods][INFO    ][24747] Loading cache from salt://_engines, for base)
2017-10-27 19:49:21,503 [salt.fileclient  ][INFO    ][24747] Caching directory '_engines/' for environment 'base'
2017-10-27 19:49:21,544 [salt.minion      ][INFO    ][24747] Returning information for job: 20171027194911295492
2017-10-27 19:58:19,561 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command test.ping with jid 20171027195819553040
2017-10-27 19:58:19,589 [salt.minion      ][INFO    ][24989] Starting a new job with PID 24989
2017-10-27 19:58:19,638 [salt.minion      ][INFO    ][24989] Returning information for job: 20171027195819553040
2017-10-27 19:59:25,114 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command state.sls with jid 20171027195925107224
2017-10-27 19:59:25,141 [salt.minion      ][INFO    ][25020] Starting a new job with PID 25020
2017-10-27 19:59:27,332 [salt.state       ][INFO    ][25020] Loading fresh modules for state activity
2017-10-27 19:59:27,371 [salt.fileclient  ][INFO    ][25020] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-27 19:59:27,396 [salt.fileclient  ][INFO    ][25020] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-27 19:59:27,434 [salt.fileclient  ][INFO    ][25020] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:59:27,839 [salt.state       ][INFO    ][25020] Running state [lsof] at time 19:59:27.838523
2017-10-27 19:59:27,839 [salt.state       ][INFO    ][25020] Executing state pkg.installed for lsof
2017-10-27 19:59:27,840 [salt.loaded.int.module.cmdmod][INFO    ][25020] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 19:59:28,200 [salt.state       ][INFO    ][25020] Package lsof is already installed
2017-10-27 19:59:28,200 [salt.state       ][INFO    ][25020] Completed state [lsof] at time 19:59:28.200446 duration_in_ms=361.922
2017-10-27 19:59:28,201 [salt.state       ][INFO    ][25020] Running state [keepalived] at time 19:59:28.201289
2017-10-27 19:59:28,202 [salt.state       ][INFO    ][25020] Executing state pkg.installed for keepalived
2017-10-27 19:59:28,237 [salt.loaded.int.module.cmdmod][INFO    ][25020] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-27 19:59:30,854 [salt.loaded.int.module.cmdmod][INFO    ][25020] 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-10-27 19:59:35,126 [salt.loaded.int.module.cmdmod][INFO    ][25020] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 19:59:35,165 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027195935154450
2017-10-27 19:59:35,187 [salt.minion      ][INFO    ][26532] Starting a new job with PID 26532
2017-10-27 19:59:35,188 [salt.state       ][INFO    ][25020] 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-10-27 19:59:35,201 [salt.state       ][INFO    ][25020] Loading fresh modules for state activity
2017-10-27 19:59:35,205 [salt.minion      ][INFO    ][26532] Returning information for job: 20171027195935154450
2017-10-27 19:59:35,221 [salt.state       ][INFO    ][25020] Completed state [keepalived] at time 19:59:35.220639 duration_in_ms=7019.353
2017-10-27 19:59:35,223 [salt.state       ][INFO    ][25020] Running state [/etc/keepalived/keepalived.conf] at time 19:59:35.223121
2017-10-27 19:59:35,223 [salt.state       ][INFO    ][25020] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-27 19:59:35,257 [salt.fileclient  ][INFO    ][25020] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-27 19:59:35,312 [salt.fileclient  ][INFO    ][25020] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:59:35,328 [salt.state       ][INFO    ][25020] File changed:
New file
2017-10-27 19:59:35,328 [salt.state       ][INFO    ][25020] Completed state [/etc/keepalived/keepalived.conf] at time 19:59:35.328149 duration_in_ms=105.027
2017-10-27 19:59:35,452 [salt.state       ][INFO    ][25020] Running state [keepalived] at time 19:59:35.451573
2017-10-27 19:59:35,452 [salt.state       ][INFO    ][25020] Executing state service.running for keepalived
2017-10-27 19:59:35,455 [salt.loaded.int.module.cmdmod][INFO    ][25020] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-27 19:59:35,479 [salt.loaded.int.module.cmdmod][INFO    ][25020] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:35,500 [salt.loaded.int.module.cmdmod][INFO    ][25020] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:35,520 [salt.loaded.int.module.cmdmod][INFO    ][25020] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:35,535 [salt.loaded.int.module.cmdmod][INFO    ][25020] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:35,617 [salt.loaded.int.module.cmdmod][INFO    ][25020] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:35,644 [salt.loaded.int.module.cmdmod][INFO    ][25020] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:35,660 [salt.loaded.int.module.cmdmod][INFO    ][25020] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:35,671 [salt.state       ][INFO    ][25020] {'keepalived': True}
2017-10-27 19:59:35,672 [salt.state       ][INFO    ][25020] Completed state [keepalived] at time 19:59:35.671661 duration_in_ms=220.088
2017-10-27 19:59:35,673 [salt.minion      ][INFO    ][25020] Returning information for job: 20171027195925107224
2017-10-27 20:00:33,637 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command pillar.get with jid 20171027200033630413
2017-10-27 20:00:33,665 [salt.minion      ][INFO    ][26637] Starting a new job with PID 26637
2017-10-27 20:00:33,670 [salt.minion      ][INFO    ][26637] Returning information for job: 20171027200033630413
2017-10-27 20:05:11,442 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command state.sls with jid 20171027200511435264
2017-10-27 20:05:11,470 [salt.minion      ][INFO    ][26720] Starting a new job with PID 26720
2017-10-27 20:05:14,098 [salt.state       ][INFO    ][26720] Loading fresh modules for state activity
2017-10-27 20:05:14,140 [salt.fileclient  ][INFO    ][26720] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 20:05:14,177 [salt.fileclient  ][INFO    ][26720] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:05:14,559 [salt.state       ][INFO    ][26720] Running state [attr] at time 20:05:14.558941
2017-10-27 20:05:14,559 [salt.state       ][INFO    ][26720] Executing state pkg.installed for attr
2017-10-27 20:05:14,560 [salt.loaded.int.module.cmdmod][INFO    ][26720] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:05:14,927 [salt.loaded.int.module.cmdmod][INFO    ][26720] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-27 20:05:17,558 [salt.loaded.int.module.cmdmod][INFO    ][26720] 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-10-27 20:05:19,757 [salt.loaded.int.module.cmdmod][INFO    ][26720] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:05:19,816 [salt.state       ][INFO    ][26720] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-10-27 20:05:19,853 [salt.state       ][INFO    ][26720] Loading fresh modules for state activity
2017-10-27 20:05:19,874 [salt.state       ][INFO    ][26720] Completed state [attr] at time 20:05:19.873479 duration_in_ms=5314.537
2017-10-27 20:05:19,880 [salt.state       ][INFO    ][26720] Running state [glusterfs-server] at time 20:05:19.879854
2017-10-27 20:05:19,880 [salt.state       ][INFO    ][26720] Executing state pkg.installed for glusterfs-server
2017-10-27 20:05:20,201 [salt.loaded.int.module.cmdmod][INFO    ][26720] 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-10-27 20:05:21,557 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027200521544322
2017-10-27 20:05:21,584 [salt.minion      ][INFO    ][27788] Starting a new job with PID 27788
2017-10-27 20:05:21,608 [salt.minion      ][INFO    ][27788] Returning information for job: 20171027200521544322
2017-10-27 20:05:31,009 [salt.loaded.int.module.cmdmod][INFO    ][26720] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:05:31,071 [salt.state       ][INFO    ][26720] 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-10-27 20:05:31,087 [salt.state       ][INFO    ][26720] Loading fresh modules for state activity
2017-10-27 20:05:31,109 [salt.state       ][INFO    ][26720] Completed state [glusterfs-server] at time 20:05:31.108728 duration_in_ms=11228.873
2017-10-27 20:05:31,116 [salt.state       ][INFO    ][26720] Running state [bc] at time 20:05:31.115843
2017-10-27 20:05:31,116 [salt.state       ][INFO    ][26720] Executing state pkg.installed for bc
2017-10-27 20:05:31,476 [salt.loaded.int.module.cmdmod][INFO    ][26720] 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-10-27 20:05:31,971 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027200531745812
2017-10-27 20:05:31,991 [salt.minion      ][INFO    ][31126] Starting a new job with PID 31126
2017-10-27 20:05:32,005 [salt.minion      ][INFO    ][31126] Returning information for job: 20171027200531745812
2017-10-27 20:05:33,562 [salt.loaded.int.module.cmdmod][INFO    ][26720] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:05:33,631 [salt.state       ][INFO    ][26720] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-10-27 20:05:33,648 [salt.state       ][INFO    ][26720] Loading fresh modules for state activity
2017-10-27 20:05:33,694 [salt.state       ][INFO    ][26720] Completed state [bc] at time 20:05:33.694439 duration_in_ms=2578.595
2017-10-27 20:05:33,776 [salt.state       ][INFO    ][26720] Running state [glusterfs-server] at time 20:05:33.776172
2017-10-27 20:05:33,776 [salt.state       ][INFO    ][26720] Executing state service.running for glusterfs-server
2017-10-27 20:05:33,778 [salt.loaded.int.module.cmdmod][INFO    ][26720] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:05:33,795 [salt.loaded.int.module.cmdmod][INFO    ][26720] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:05:33,808 [salt.loaded.int.module.cmdmod][INFO    ][26720] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:05:33,828 [salt.state       ][INFO    ][26720] The service glusterfs-server is already running
2017-10-27 20:05:33,828 [salt.state       ][INFO    ][26720] Completed state [glusterfs-server] at time 20:05:33.827901 duration_in_ms=51.729
2017-10-27 20:05:33,831 [salt.state       ][INFO    ][26720] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:05:33.831303
2017-10-27 20:05:33,832 [salt.state       ][INFO    ][26720] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 20:05:33,845 [salt.state       ][INFO    ][26720] File changed:
New file
2017-10-27 20:05:33,846 [salt.state       ][INFO    ][26720] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:05:33.846226 duration_in_ms=14.923
2017-10-27 20:05:33,847 [salt.state       ][INFO    ][26720] Running state [/srv/glusterfs/glance] at time 20:05:33.846560
2017-10-27 20:05:33,847 [salt.state       ][INFO    ][26720] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 20:05:33,848 [salt.state       ][INFO    ][26720] {'/srv/glusterfs/glance': 'New Dir'}
2017-10-27 20:05:33,848 [salt.state       ][INFO    ][26720] Completed state [/srv/glusterfs/glance] at time 20:05:33.848183 duration_in_ms=1.623
2017-10-27 20:05:33,849 [salt.state       ][INFO    ][26720] Running state [/srv/glusterfs/keystone-keys] at time 20:05:33.848462
2017-10-27 20:05:33,849 [salt.state       ][INFO    ][26720] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 20:05:33,849 [salt.state       ][INFO    ][26720] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-10-27 20:05:33,850 [salt.state       ][INFO    ][26720] Completed state [/srv/glusterfs/keystone-keys] at time 20:05:33.850275 duration_in_ms=1.812
2017-10-27 20:05:33,851 [salt.state       ][INFO    ][26720] Running state [/srv/glusterfs/nova_instances] at time 20:05:33.850551
2017-10-27 20:05:33,851 [salt.state       ][INFO    ][26720] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 20:05:33,852 [salt.state       ][INFO    ][26720] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-10-27 20:05:33,852 [salt.state       ][INFO    ][26720] Completed state [/srv/glusterfs/nova_instances] at time 20:05:33.851775 duration_in_ms=1.223
2017-10-27 20:05:33,853 [salt.state       ][INFO    ][26720] Running state [/srv/glusterfs/keystone-credential-keys] at time 20:05:33.852626
2017-10-27 20:05:33,853 [salt.state       ][INFO    ][26720] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 20:05:33,855 [salt.state       ][INFO    ][26720] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-10-27 20:05:33,855 [salt.state       ][INFO    ][26720] Completed state [/srv/glusterfs/keystone-credential-keys] at time 20:05:33.854866 duration_in_ms=2.24
2017-10-27 20:05:33,857 [salt.minion      ][INFO    ][26720] Returning information for job: 20171027200511435264
2017-10-27 20:05:34,896 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command test.ping with jid 20171027200534888220
2017-10-27 20:05:34,917 [salt.minion      ][INFO    ][31525] Starting a new job with PID 31525
2017-10-27 20:05:34,960 [salt.minion      ][INFO    ][31525] Returning information for job: 20171027200534888220
2017-10-27 20:05:35,092 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command state.sls with jid 20171027200535081289
2017-10-27 20:05:35,116 [salt.minion      ][INFO    ][31530] Starting a new job with PID 31530
2017-10-27 20:05:37,269 [salt.state       ][INFO    ][31530] Loading fresh modules for state activity
2017-10-27 20:05:37,304 [salt.fileclient  ][INFO    ][31530] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-27 20:05:37,358 [salt.fileclient  ][INFO    ][31530] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:05:37,464 [salt.fileclient  ][INFO    ][31530] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 20:05:37,502 [salt.fileclient  ][INFO    ][31530] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:05:37,876 [salt.state       ][INFO    ][31530] Running state [attr] at time 20:05:37.875831
2017-10-27 20:05:37,876 [salt.state       ][INFO    ][31530] Executing state pkg.installed for attr
2017-10-27 20:05:37,877 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:05:38,201 [salt.state       ][INFO    ][31530] Package attr is already installed
2017-10-27 20:05:38,201 [salt.state       ][INFO    ][31530] Completed state [attr] at time 20:05:38.200898 duration_in_ms=325.066
2017-10-27 20:05:38,201 [salt.state       ][INFO    ][31530] Running state [glusterfs-server] at time 20:05:38.201189
2017-10-27 20:05:38,201 [salt.state       ][INFO    ][31530] Executing state pkg.installed for glusterfs-server
2017-10-27 20:05:38,205 [salt.state       ][INFO    ][31530] Package glusterfs-server is already installed
2017-10-27 20:05:38,206 [salt.state       ][INFO    ][31530] Completed state [glusterfs-server] at time 20:05:38.205529 duration_in_ms=4.34
2017-10-27 20:05:38,206 [salt.state       ][INFO    ][31530] Running state [bc] at time 20:05:38.206084
2017-10-27 20:05:38,206 [salt.state       ][INFO    ][31530] Executing state pkg.installed for bc
2017-10-27 20:05:38,210 [salt.state       ][INFO    ][31530] Package bc is already installed
2017-10-27 20:05:38,210 [salt.state       ][INFO    ][31530] Completed state [bc] at time 20:05:38.210042 duration_in_ms=3.957
2017-10-27 20:05:38,211 [salt.state       ][INFO    ][31530] Running state [glusterfs-server] at time 20:05:38.211075
2017-10-27 20:05:38,211 [salt.state       ][INFO    ][31530] Executing state service.running for glusterfs-server
2017-10-27 20:05:38,212 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:05:38,231 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-10-27 20:05:38,319 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:05:38,353 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:05:38,369 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:05:38,393 [salt.state       ][INFO    ][31530] The service glusterfs-server is already running
2017-10-27 20:05:38,394 [salt.state       ][INFO    ][31530] Completed state [glusterfs-server] at time 20:05:38.394060 duration_in_ms=182.983
2017-10-27 20:05:38,397 [salt.state       ][INFO    ][31530] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:05:38.397046
2017-10-27 20:05:38,397 [salt.state       ][INFO    ][31530] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 20:05:38,402 [salt.state       ][INFO    ][31530] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-27 20:05:38,403 [salt.state       ][INFO    ][31530] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:05:38.403326 duration_in_ms=6.28
2017-10-27 20:05:38,404 [salt.state       ][INFO    ][31530] Running state [/srv/glusterfs/glance] at time 20:05:38.403647
2017-10-27 20:05:38,404 [salt.state       ][INFO    ][31530] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 20:05:38,405 [salt.state       ][INFO    ][31530] Directory /srv/glusterfs/glance is in the correct state
2017-10-27 20:05:38,405 [salt.state       ][INFO    ][31530] Completed state [/srv/glusterfs/glance] at time 20:05:38.404848 duration_in_ms=1.201
2017-10-27 20:05:38,405 [salt.state       ][INFO    ][31530] Running state [/srv/glusterfs/keystone-keys] at time 20:05:38.405142
2017-10-27 20:05:38,405 [salt.state       ][INFO    ][31530] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 20:05:38,407 [salt.state       ][INFO    ][31530] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-27 20:05:38,407 [salt.state       ][INFO    ][31530] Completed state [/srv/glusterfs/keystone-keys] at time 20:05:38.407225 duration_in_ms=2.083
2017-10-27 20:05:38,408 [salt.state       ][INFO    ][31530] Running state [/srv/glusterfs/nova_instances] at time 20:05:38.407512
2017-10-27 20:05:38,408 [salt.state       ][INFO    ][31530] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 20:05:38,408 [salt.state       ][INFO    ][31530] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-27 20:05:38,409 [salt.state       ][INFO    ][31530] Completed state [/srv/glusterfs/nova_instances] at time 20:05:38.408655 duration_in_ms=1.142
2017-10-27 20:05:38,409 [salt.state       ][INFO    ][31530] Running state [/srv/glusterfs/keystone-credential-keys] at time 20:05:38.408941
2017-10-27 20:05:38,409 [salt.state       ][INFO    ][31530] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 20:05:38,410 [salt.state       ][INFO    ][31530] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-27 20:05:38,411 [salt.state       ][INFO    ][31530] Completed state [/srv/glusterfs/keystone-credential-keys] at time 20:05:38.410578 duration_in_ms=1.637
2017-10-27 20:05:38,477 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command ['git', '--version'] in directory '/root'
2017-10-27 20:05:38,609 [salt.state       ][INFO    ][31530] Running state [sleep 5] at time 20:05:38.608794
2017-10-27 20:05:38,609 [salt.state       ][INFO    ][31530] Executing state cmd.wait for sleep 5
2017-10-27 20:05:38,610 [salt.state       ][INFO    ][31530] No changes made for sleep 5
2017-10-27 20:05:38,610 [salt.state       ][INFO    ][31530] Completed state [sleep 5] at time 20:05:38.609827 duration_in_ms=1.034
2017-10-27 20:05:38,610 [salt.state       ][INFO    ][31530] Running state [192.168.10.143] at time 20:05:38.610369
2017-10-27 20:05:38,611 [salt.state       ][INFO    ][31530] Executing state glusterfs.peered for 192.168.10.143
2017-10-27 20:05:38,611 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:38,628 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:38,712 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:38,735 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:38,840 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:38,863 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:38,947 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:38,965 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:39,053 [salt.state       ][INFO    ][31530] {'new': {'192.168.10.143': []}, 'old': None}
2017-10-27 20:05:39,055 [salt.state       ][INFO    ][31530] Completed state [192.168.10.143] at time 20:05:39.054600 duration_in_ms=444.23
2017-10-27 20:05:39,063 [salt.state       ][INFO    ][31530] Running state [192.168.10.142] at time 20:05:39.063249
2017-10-27 20:05:39,064 [salt.state       ][INFO    ][31530] Executing state glusterfs.peered for 192.168.10.142
2017-10-27 20:05:39,064 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:39,084 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:39,166 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:39,184 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:39,271 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:39,288 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:39,365 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:39,388 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:39,469 [salt.state       ][INFO    ][31530] Peering with localhost is not needed
2017-10-27 20:05:39,469 [salt.state       ][INFO    ][31530] Completed state [192.168.10.142] at time 20:05:39.469021 duration_in_ms=405.771
2017-10-27 20:05:39,477 [salt.state       ][INFO    ][31530] Running state [192.168.10.141] at time 20:05:39.477418
2017-10-27 20:05:39,479 [salt.state       ][INFO    ][31530] Executing state glusterfs.peered for 192.168.10.141
2017-10-27 20:05:39,480 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:39,495 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:39,570 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:39,588 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:39,683 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:39,705 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:39,788 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:39,807 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:39,884 [salt.state       ][INFO    ][31530] {'new': {'192.168.10.143': [], '192.168.10.141': []}, 'old': {'192.168.10.143': []}}
2017-10-27 20:05:39,885 [salt.state       ][INFO    ][31530] Completed state [192.168.10.141] at time 20:05:39.884734 duration_in_ms=407.316
2017-10-27 20:05:39,888 [salt.state       ][INFO    ][31530] Running state [glance] at time 20:05:39.888088
2017-10-27 20:05:39,889 [salt.state       ][INFO    ][31530] Executing state glusterfs.created for glance
2017-10-27 20:05:39,891 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:39,910 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:39,996 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:40,015 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:40,135 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:40,160 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:40,668 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:40,692 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:40,777 [salt.state       ][INFO    ][31530] {'new': ['glance'], 'old': []}
2017-10-27 20:05:40,779 [salt.state       ][INFO    ][31530] Completed state [glance] at time 20:05:40.777539 duration_in_ms=889.45
2017-10-27 20:05:40,791 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 20:05:40.791294
2017-10-27 20:05:40,792 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:05:40,792 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:05:40,883 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-27 20:05:41,028 [salt.state       ][INFO    ][31530] {'pid': 31752, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:41,029 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 20:05:41.029029 duration_in_ms=237.733
2017-10-27 20:05:41,032 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 20:05:41.032345
2017-10-27 20:05:41,033 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-27 20:05:41,035 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:05:41,129 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-10-27 20:05:41,283 [salt.state       ][INFO    ][31530] {'pid': 31770, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:41,283 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 20:05:41.283260 duration_in_ms=250.915
2017-10-27 20:05:41,285 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 20:05:41.284522
2017-10-27 20:05:41,285 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-27 20:05:41,288 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:05:41,376 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-10-27 20:05:43,540 [salt.state       ][INFO    ][31530] {'pid': 31787, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:43,541 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 20:05:43.540433 duration_in_ms=2255.91
2017-10-27 20:05:43,543 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 20:05:43.543275
2017-10-27 20:05:43,544 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:05:43,545 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:05:43,635 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-27 20:05:43,782 [salt.state       ][INFO    ][31530] {'pid': 31805, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:43,782 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 20:05:43.782392 duration_in_ms=239.117
2017-10-27 20:05:43,784 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 20:05:43.783747
2017-10-27 20:05:43,784 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-27 20:05:43,785 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:05:43,870 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-10-27 20:05:44,027 [salt.state       ][INFO    ][31530] {'pid': 31822, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:44,027 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 20:05:44.027119 duration_in_ms=243.37
2017-10-27 20:05:44,031 [salt.state       ][INFO    ][31530] Running state [glance] at time 20:05:44.030862
2017-10-27 20:05:44,031 [salt.state       ][INFO    ][31530] Executing state glusterfs.started for glance
2017-10-27 20:05:44,032 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:44,052 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:44,132 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:44,151 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:44,244 [salt.state       ][INFO    ][31530] Volume glance is already started
2017-10-27 20:05:44,244 [salt.state       ][INFO    ][31530] Completed state [glance] at time 20:05:44.244104 duration_in_ms=213.24
2017-10-27 20:05:44,249 [salt.state       ][INFO    ][31530] Running state [keystone-keys] at time 20:05:44.248897
2017-10-27 20:05:44,250 [salt.state       ][INFO    ][31530] Executing state glusterfs.created for keystone-keys
2017-10-27 20:05:44,251 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:44,272 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:44,351 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:44,369 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:44,491 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:44,513 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:45,144 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027200545130677
2017-10-27 20:05:45,168 [salt.minion      ][INFO    ][31902] Starting a new job with PID 31902
2017-10-27 20:05:45,186 [salt.minion      ][INFO    ][31902] Returning information for job: 20171027200545130677
2017-10-27 20:05:46,722 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:46,749 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:46,829 [salt.state       ][INFO    ][31530] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-10-27 20:05:46,829 [salt.state       ][INFO    ][31530] Completed state [keystone-keys] at time 20:05:46.829373 duration_in_ms=2580.477
2017-10-27 20:05:46,840 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 20:05:46.840056
2017-10-27 20:05:46,840 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-27 20:05:46,841 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:05:46,924 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-10-27 20:05:47,117 [salt.state       ][INFO    ][31530] {'pid': 31944, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:47,117 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 20:05:47.117308 duration_in_ms=277.25
2017-10-27 20:05:47,121 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:05:47.121113
2017-10-27 20:05:47,123 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:05:47,124 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:05:47,210 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-27 20:05:47,361 [salt.state       ][INFO    ][31530] {'pid': 31961, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:47,362 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:05:47.361413 duration_in_ms=240.299
2017-10-27 20:05:47,363 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:05:47.363049
2017-10-27 20:05:47,364 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:05:47,365 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:05:47,460 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-27 20:05:47,627 [salt.state       ][INFO    ][31530] {'pid': 31979, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:47,628 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:05:47.627050 duration_in_ms=264.0
2017-10-27 20:05:47,629 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 20:05:47.629079
2017-10-27 20:05:47,630 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-27 20:05:47,631 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:05:47,718 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-10-27 20:05:49,892 [salt.state       ][INFO    ][31530] {'pid': 31996, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:49,893 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 20:05:49.893056 duration_in_ms=2263.976
2017-10-27 20:05:49,895 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 20:05:49.895158
2017-10-27 20:05:49,896 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 20:05:49,897 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:05:49,982 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-10-27 20:05:50,139 [salt.state       ][INFO    ][31530] {'pid': 32013, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:50,140 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 20:05:50.139596 duration_in_ms=244.438
2017-10-27 20:05:50,144 [salt.state       ][INFO    ][31530] Running state [keystone-keys] at time 20:05:50.143548
2017-10-27 20:05:50,144 [salt.state       ][INFO    ][31530] Executing state glusterfs.started for keystone-keys
2017-10-27 20:05:50,146 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:50,166 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:50,243 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:50,263 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:50,351 [salt.state       ][INFO    ][31530] Volume keystone-keys is already started
2017-10-27 20:05:50,352 [salt.state       ][INFO    ][31530] Completed state [keystone-keys] at time 20:05:50.351731 duration_in_ms=208.182
2017-10-27 20:05:50,356 [salt.state       ][INFO    ][31530] Running state [nova_instances] at time 20:05:50.356088
2017-10-27 20:05:50,357 [salt.state       ][INFO    ][31530] Executing state glusterfs.created for nova_instances
2017-10-27 20:05:50,359 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:50,384 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:50,471 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:50,488 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:50,608 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:50,629 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:52,856 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:52,884 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:52,963 [salt.state       ][INFO    ][31530] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-10-27 20:05:52,963 [salt.state       ][INFO    ][31530] Completed state [nova_instances] at time 20:05:52.963279 duration_in_ms=2607.192
2017-10-27 20:05:52,973 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 20:05:52.972891
2017-10-27 20:05:52,973 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:05:52,976 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:05:53,068 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-27 20:05:53,233 [salt.state       ][INFO    ][31530] {'pid': 32128, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:53,235 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 20:05:53.234481 duration_in_ms=261.589
2017-10-27 20:05:53,236 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 20:05:53.235739
2017-10-27 20:05:53,236 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-27 20:05:53,237 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-27 20:05:53,327 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'' in directory '/root'
2017-10-27 20:05:53,493 [salt.state       ][INFO    ][31530] {'pid': 32146, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:53,494 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 20:05:53.494336 duration_in_ms=258.597
2017-10-27 20:05:53,496 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 20:05:53.495743
2017-10-27 20:05:53,496 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-27 20:05:53,497 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-27 20:05:53,587 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'On'' in directory '/root'
2017-10-27 20:05:53,756 [salt.state       ][INFO    ][31530] {'pid': 32163, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:53,756 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 20:05:53.756147 duration_in_ms=260.403
2017-10-27 20:05:53,759 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 20:05:53.758807
2017-10-27 20:05:53,759 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-27 20:05:53,760 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-27 20:05:53,847 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'On'' in directory '/root'
2017-10-27 20:05:55,329 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027200555317886
2017-10-27 20:05:55,356 [salt.minion      ][INFO    ][32190] Starting a new job with PID 32190
2017-10-27 20:05:55,376 [salt.minion      ][INFO    ][32190] Returning information for job: 20171027200555317886
2017-10-27 20:05:56,027 [salt.state       ][INFO    ][31530] {'pid': 32180, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:56,028 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 20:05:56.027182 duration_in_ms=2268.374
2017-10-27 20:05:56,029 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 20:05:56.028501
2017-10-27 20:05:56,029 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:05:56,031 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:05:56,129 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-27 20:05:56,287 [salt.state       ][INFO    ][31530] {'pid': 32202, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:56,287 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 20:05:56.287331 duration_in_ms=258.829
2017-10-27 20:05:56,291 [salt.state       ][INFO    ][31530] Running state [nova_instances] at time 20:05:56.291194
2017-10-27 20:05:56,292 [salt.state       ][INFO    ][31530] Executing state glusterfs.started for nova_instances
2017-10-27 20:05:56,293 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:56,312 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:56,394 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:56,413 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:56,500 [salt.state       ][INFO    ][31530] Volume nova_instances is already started
2017-10-27 20:05:56,500 [salt.state       ][INFO    ][31530] Completed state [nova_instances] at time 20:05:56.500280 duration_in_ms=209.085
2017-10-27 20:05:56,504 [salt.state       ][INFO    ][31530] Running state [keystone-credential-keys] at time 20:05:56.503476
2017-10-27 20:05:56,504 [salt.state       ][INFO    ][31530] Executing state glusterfs.created for keystone-credential-keys
2017-10-27 20:05:56,505 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:56,528 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:56,609 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:56,629 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:56,745 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:56,764 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:58,995 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:05:59,031 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:05:59,119 [salt.state       ][INFO    ][31530] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-10-27 20:05:59,120 [salt.state       ][INFO    ][31530] Completed state [keystone-credential-keys] at time 20:05:59.119641 duration_in_ms=2616.164
2017-10-27 20:05:59,133 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 20:05:59.132876
2017-10-27 20:05:59,133 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 20:05:59,134 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:05:59,222 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-10-27 20:05:59,395 [salt.state       ][INFO    ][31530] {'pid': 32322, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:59,396 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 20:05:59.395816 duration_in_ms=262.938
2017-10-27 20:05:59,398 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:05:59.397501
2017-10-27 20:05:59,400 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:05:59,401 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:05:59,487 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-27 20:05:59,651 [salt.state       ][INFO    ][31530] {'pid': 32339, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:05:59,651 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:05:59.651365 duration_in_ms=253.862
2017-10-27 20:05:59,653 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 20:05:59.652723
2017-10-27 20:05:59,653 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-27 20:05:59,656 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:05:59,744 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-10-27 20:06:01,924 [salt.state       ][INFO    ][31530] {'pid': 32357, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:06:01,924 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 20:06:01.924182 duration_in_ms=2271.458
2017-10-27 20:06:01,927 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:01.926473
2017-10-27 20:06:01,927 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:06:01,928 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:02,029 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-27 20:06:02,184 [salt.state       ][INFO    ][31530] {'pid': 32374, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:06:02,184 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:02.184181 duration_in_ms=257.704
2017-10-27 20:06:02,186 [salt.state       ][INFO    ][31530] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 20:06:02.185476
2017-10-27 20:06:02,187 [salt.state       ][INFO    ][31530] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-27 20:06:02,188 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:06:02,274 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-10-27 20:06:02,429 [salt.state       ][INFO    ][31530] {'pid': 32391, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-27 20:06:02,429 [salt.state       ][INFO    ][31530] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 20:06:02.428986 duration_in_ms=243.509
2017-10-27 20:06:02,434 [salt.state       ][INFO    ][31530] Running state [keystone-credential-keys] at time 20:06:02.433582
2017-10-27 20:06:02,435 [salt.state       ][INFO    ][31530] Executing state glusterfs.started for keystone-credential-keys
2017-10-27 20:06:02,436 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:02,455 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:02,534 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:02,552 [salt.loaded.int.module.cmdmod][INFO    ][31530] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:02,637 [salt.state       ][INFO    ][31530] Volume keystone-credential-keys is already started
2017-10-27 20:06:02,637 [salt.state       ][INFO    ][31530] Completed state [keystone-credential-keys] at time 20:06:02.637119 duration_in_ms=203.536
2017-10-27 20:06:02,652 [salt.minion      ][INFO    ][31530] Returning information for job: 20171027200535081289
2017-10-27 20:06:13,936 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command test.ping with jid 20171027200613929097
2017-10-27 20:06:13,963 [salt.minion      ][INFO    ][32420] Starting a new job with PID 32420
2017-10-27 20:06:14,009 [salt.minion      ][INFO    ][32420] Returning information for job: 20171027200613929097
2017-10-27 20:06:14,136 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command cmd.run with jid 20171027200614128909
2017-10-27 20:06:14,157 [salt.minion      ][INFO    ][32425] Starting a new job with PID 32425
2017-10-27 20:06:14,166 [salt.loaded.int.module.cmdmod][INFO    ][32425] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-27 20:06:14,340 [salt.minion      ][INFO    ][32425] Returning information for job: 20171027200614128909
2017-10-27 20:46:11,319 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command test.ping with jid 20171027204611312459
2017-10-27 20:46:11,352 [salt.minion      ][INFO    ][32979] Starting a new job with PID 32979
2017-10-27 20:46:11,414 [salt.minion      ][INFO    ][32979] Returning information for job: 20171027204611312459
2017-10-27 20:46:30,347 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command state.sls with jid 20171027204630339409
2017-10-27 20:46:30,369 [salt.minion      ][INFO    ][32987] Starting a new job with PID 32987
2017-10-27 20:46:30,953 [salt.state       ][INFO    ][32987] Loading fresh modules for state activity
2017-10-27 20:46:30,992 [salt.fileclient  ][INFO    ][32987] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-27 20:46:31,025 [salt.fileclient  ][INFO    ][32987] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-27 20:46:31,072 [salt.fileclient  ][INFO    ][32987] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 20:46:31,483 [salt.state       ][INFO    ][32987] Running state [lsof] at time 20:46:31.483019
2017-10-27 20:46:31,484 [salt.state       ][INFO    ][32987] Executing state pkg.installed for lsof
2017-10-27 20:46:31,484 [salt.loaded.int.module.cmdmod][INFO    ][32987] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:46:31,879 [salt.state       ][INFO    ][32987] Package lsof is already installed
2017-10-27 20:46:31,879 [salt.state       ][INFO    ][32987] Completed state [lsof] at time 20:46:31.879231 duration_in_ms=396.211
2017-10-27 20:46:31,879 [salt.state       ][INFO    ][32987] Running state [keepalived] at time 20:46:31.879468
2017-10-27 20:46:31,880 [salt.state       ][INFO    ][32987] Executing state pkg.installed for keepalived
2017-10-27 20:46:31,884 [salt.state       ][INFO    ][32987] Package keepalived is already installed
2017-10-27 20:46:31,884 [salt.state       ][INFO    ][32987] Completed state [keepalived] at time 20:46:31.884072 duration_in_ms=4.603
2017-10-27 20:46:31,887 [salt.state       ][INFO    ][32987] Running state [/etc/keepalived/keepalived.conf] at time 20:46:31.886474
2017-10-27 20:46:31,887 [salt.state       ][INFO    ][32987] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-27 20:46:31,920 [salt.fileclient  ][INFO    ][32987] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-27 20:46:31,976 [salt.fileclient  ][INFO    ][32987] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 20:46:31,988 [salt.state       ][INFO    ][32987] File /etc/keepalived/keepalived.conf is in the correct state
2017-10-27 20:46:31,989 [salt.state       ][INFO    ][32987] Completed state [/etc/keepalived/keepalived.conf] at time 20:46:31.989105 duration_in_ms=102.631
2017-10-27 20:46:31,990 [salt.state       ][INFO    ][32987] Running state [keepalived] at time 20:46:31.989913
2017-10-27 20:46:31,990 [salt.state       ][INFO    ][32987] Executing state service.running for keepalived
2017-10-27 20:46:31,991 [salt.loaded.int.module.cmdmod][INFO    ][32987] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-27 20:46:32,031 [salt.loaded.int.module.cmdmod][INFO    ][32987] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 20:46:32,055 [salt.loaded.int.module.cmdmod][INFO    ][32987] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 20:46:32,076 [salt.state       ][INFO    ][32987] The service keepalived is already running
2017-10-27 20:46:32,077 [salt.state       ][INFO    ][32987] Completed state [keepalived] at time 20:46:32.076661 duration_in_ms=86.746
2017-10-27 20:46:32,080 [salt.minion      ][INFO    ][32987] Returning information for job: 20171027204630339409
2017-10-27 20:46:49,255 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command pillar.get with jid 20171027204649246891
2017-10-27 20:46:49,289 [salt.minion      ][INFO    ][33013] Starting a new job with PID 33013
2017-10-27 20:46:49,295 [salt.minion      ][INFO    ][33013] Returning information for job: 20171027204649246891
2017-10-27 20:47:39,824 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command state.sls with jid 20171027204739817899
2017-10-27 20:47:39,845 [salt.minion      ][INFO    ][33021] Starting a new job with PID 33021
2017-10-27 20:47:42,470 [salt.state       ][INFO    ][33021] Loading fresh modules for state activity
2017-10-27 20:47:42,500 [salt.fileclient  ][INFO    ][33021] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 20:47:42,536 [salt.fileclient  ][INFO    ][33021] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:47:42,958 [salt.state       ][INFO    ][33021] Running state [attr] at time 20:47:42.957528
2017-10-27 20:47:42,958 [salt.state       ][INFO    ][33021] Executing state pkg.installed for attr
2017-10-27 20:47:42,959 [salt.loaded.int.module.cmdmod][INFO    ][33021] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:47:43,346 [salt.state       ][INFO    ][33021] Package attr is already installed
2017-10-27 20:47:43,346 [salt.state       ][INFO    ][33021] Completed state [attr] at time 20:47:43.346248 duration_in_ms=388.72
2017-10-27 20:47:43,347 [salt.state       ][INFO    ][33021] Running state [glusterfs-server] at time 20:47:43.346518
2017-10-27 20:47:43,347 [salt.state       ][INFO    ][33021] Executing state pkg.installed for glusterfs-server
2017-10-27 20:47:43,353 [salt.state       ][INFO    ][33021] Package glusterfs-server is already installed
2017-10-27 20:47:43,353 [salt.state       ][INFO    ][33021] Completed state [glusterfs-server] at time 20:47:43.353169 duration_in_ms=6.649
2017-10-27 20:47:43,354 [salt.state       ][INFO    ][33021] Running state [bc] at time 20:47:43.353724
2017-10-27 20:47:43,354 [salt.state       ][INFO    ][33021] Executing state pkg.installed for bc
2017-10-27 20:47:43,359 [salt.state       ][INFO    ][33021] Package bc is already installed
2017-10-27 20:47:43,359 [salt.state       ][INFO    ][33021] Completed state [bc] at time 20:47:43.359138 duration_in_ms=5.414
2017-10-27 20:47:43,360 [salt.state       ][INFO    ][33021] Running state [glusterfs-server] at time 20:47:43.360260
2017-10-27 20:47:43,360 [salt.state       ][INFO    ][33021] Executing state service.running for glusterfs-server
2017-10-27 20:47:43,362 [salt.loaded.int.module.cmdmod][INFO    ][33021] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:47:43,399 [salt.loaded.int.module.cmdmod][INFO    ][33021] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:47:43,416 [salt.loaded.int.module.cmdmod][INFO    ][33021] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:47:43,440 [salt.state       ][INFO    ][33021] The service glusterfs-server is already running
2017-10-27 20:47:43,441 [salt.state       ][INFO    ][33021] Completed state [glusterfs-server] at time 20:47:43.440849 duration_in_ms=80.586
2017-10-27 20:47:43,446 [salt.state       ][INFO    ][33021] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:47:43.445574
2017-10-27 20:47:43,447 [salt.state       ][INFO    ][33021] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 20:47:43,455 [salt.state       ][INFO    ][33021] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-27 20:47:43,455 [salt.state       ][INFO    ][33021] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:47:43.454986 duration_in_ms=9.413
2017-10-27 20:47:43,455 [salt.state       ][INFO    ][33021] Running state [/srv/glusterfs/glance] at time 20:47:43.455222
2017-10-27 20:47:43,455 [salt.state       ][INFO    ][33021] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 20:47:43,456 [salt.state       ][INFO    ][33021] Directory /srv/glusterfs/glance is in the correct state
2017-10-27 20:47:43,456 [salt.state       ][INFO    ][33021] Completed state [/srv/glusterfs/glance] at time 20:47:43.456136 duration_in_ms=0.915
2017-10-27 20:47:43,456 [salt.state       ][INFO    ][33021] Running state [/srv/glusterfs/keystone-keys] at time 20:47:43.456354
2017-10-27 20:47:43,457 [salt.state       ][INFO    ][33021] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 20:47:43,457 [salt.state       ][INFO    ][33021] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-27 20:47:43,457 [salt.state       ][INFO    ][33021] Completed state [/srv/glusterfs/keystone-keys] at time 20:47:43.457240 duration_in_ms=0.886
2017-10-27 20:47:43,457 [salt.state       ][INFO    ][33021] Running state [/srv/glusterfs/nova_instances] at time 20:47:43.457443
2017-10-27 20:47:43,458 [salt.state       ][INFO    ][33021] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 20:47:43,458 [salt.state       ][INFO    ][33021] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-27 20:47:43,459 [salt.state       ][INFO    ][33021] Completed state [/srv/glusterfs/nova_instances] at time 20:47:43.458598 duration_in_ms=1.154
2017-10-27 20:47:43,459 [salt.state       ][INFO    ][33021] Running state [/srv/glusterfs/keystone-credential-keys] at time 20:47:43.458807
2017-10-27 20:47:43,459 [salt.state       ][INFO    ][33021] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 20:47:43,460 [salt.state       ][INFO    ][33021] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-27 20:47:43,460 [salt.state       ][INFO    ][33021] Completed state [/srv/glusterfs/keystone-credential-keys] at time 20:47:43.459690 duration_in_ms=0.883
2017-10-27 20:47:43,461 [salt.minion      ][INFO    ][33021] Returning information for job: 20171027204739817899
2017-10-27 20:47:44,491 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command test.ping with jid 20171027204744475551
2017-10-27 20:47:44,515 [salt.minion      ][INFO    ][33044] Starting a new job with PID 33044
2017-10-27 20:47:44,571 [salt.minion      ][INFO    ][33044] Returning information for job: 20171027204744475551
2017-10-27 20:47:44,704 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command state.sls with jid 20171027204744693512
2017-10-27 20:47:44,733 [salt.minion      ][INFO    ][33049] Starting a new job with PID 33049
2017-10-27 20:47:45,336 [salt.state       ][INFO    ][33049] Loading fresh modules for state activity
2017-10-27 20:47:45,370 [salt.fileclient  ][INFO    ][33049] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-27 20:47:45,424 [salt.fileclient  ][INFO    ][33049] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:47:45,520 [salt.fileclient  ][INFO    ][33049] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 20:47:45,556 [salt.fileclient  ][INFO    ][33049] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:47:45,969 [salt.state       ][INFO    ][33049] Running state [attr] at time 20:47:45.969039
2017-10-27 20:47:45,970 [salt.state       ][INFO    ][33049] Executing state pkg.installed for attr
2017-10-27 20:47:45,970 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:47:46,331 [salt.state       ][INFO    ][33049] Package attr is already installed
2017-10-27 20:47:46,332 [salt.state       ][INFO    ][33049] Completed state [attr] at time 20:47:46.331703 duration_in_ms=362.663
2017-10-27 20:47:46,332 [salt.state       ][INFO    ][33049] Running state [glusterfs-server] at time 20:47:46.331970
2017-10-27 20:47:46,332 [salt.state       ][INFO    ][33049] Executing state pkg.installed for glusterfs-server
2017-10-27 20:47:46,336 [salt.state       ][INFO    ][33049] Package glusterfs-server is already installed
2017-10-27 20:47:46,336 [salt.state       ][INFO    ][33049] Completed state [glusterfs-server] at time 20:47:46.336007 duration_in_ms=4.038
2017-10-27 20:47:46,336 [salt.state       ][INFO    ][33049] Running state [bc] at time 20:47:46.336202
2017-10-27 20:47:46,336 [salt.state       ][INFO    ][33049] Executing state pkg.installed for bc
2017-10-27 20:47:46,341 [salt.state       ][INFO    ][33049] Package bc is already installed
2017-10-27 20:47:46,341 [salt.state       ][INFO    ][33049] Completed state [bc] at time 20:47:46.341366 duration_in_ms=5.164
2017-10-27 20:47:46,342 [salt.state       ][INFO    ][33049] Running state [glusterfs-server] at time 20:47:46.342404
2017-10-27 20:47:46,343 [salt.state       ][INFO    ][33049] Executing state service.running for glusterfs-server
2017-10-27 20:47:46,343 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:47:46,379 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:47:46,396 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:47:46,418 [salt.state       ][INFO    ][33049] The service glusterfs-server is already running
2017-10-27 20:47:46,419 [salt.state       ][INFO    ][33049] Completed state [glusterfs-server] at time 20:47:46.418849 duration_in_ms=76.444
2017-10-27 20:47:46,425 [salt.state       ][INFO    ][33049] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:47:46.425025
2017-10-27 20:47:46,426 [salt.state       ][INFO    ][33049] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 20:47:46,429 [salt.state       ][INFO    ][33049] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-27 20:47:46,430 [salt.state       ][INFO    ][33049] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:47:46.429614 duration_in_ms=4.59
2017-10-27 20:47:46,430 [salt.state       ][INFO    ][33049] Running state [/srv/glusterfs/glance] at time 20:47:46.429880
2017-10-27 20:47:46,430 [salt.state       ][INFO    ][33049] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 20:47:46,431 [salt.state       ][INFO    ][33049] Directory /srv/glusterfs/glance is in the correct state
2017-10-27 20:47:46,431 [salt.state       ][INFO    ][33049] Completed state [/srv/glusterfs/glance] at time 20:47:46.430915 duration_in_ms=1.034
2017-10-27 20:47:46,431 [salt.state       ][INFO    ][33049] Running state [/srv/glusterfs/keystone-keys] at time 20:47:46.431150
2017-10-27 20:47:46,431 [salt.state       ][INFO    ][33049] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 20:47:46,432 [salt.state       ][INFO    ][33049] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-27 20:47:46,432 [salt.state       ][INFO    ][33049] Completed state [/srv/glusterfs/keystone-keys] at time 20:47:46.432137 duration_in_ms=0.987
2017-10-27 20:47:46,433 [salt.state       ][INFO    ][33049] Running state [/srv/glusterfs/nova_instances] at time 20:47:46.432688
2017-10-27 20:47:46,433 [salt.state       ][INFO    ][33049] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 20:47:46,433 [salt.state       ][INFO    ][33049] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-27 20:47:46,434 [salt.state       ][INFO    ][33049] Completed state [/srv/glusterfs/nova_instances] at time 20:47:46.433611 duration_in_ms=0.923
2017-10-27 20:47:46,436 [salt.state       ][INFO    ][33049] Running state [/srv/glusterfs/keystone-credential-keys] at time 20:47:46.436344
2017-10-27 20:47:46,437 [salt.state       ][INFO    ][33049] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 20:47:46,437 [salt.state       ][INFO    ][33049] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-27 20:47:46,437 [salt.state       ][INFO    ][33049] Completed state [/srv/glusterfs/keystone-credential-keys] at time 20:47:46.437329 duration_in_ms=0.985
2017-10-27 20:47:46,518 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command ['git', '--version'] in directory '/root'
2017-10-27 20:47:46,673 [salt.state       ][INFO    ][33049] Running state [sleep 5] at time 20:47:46.672649
2017-10-27 20:47:46,673 [salt.state       ][INFO    ][33049] Executing state cmd.wait for sleep 5
2017-10-27 20:47:46,674 [salt.state       ][INFO    ][33049] No changes made for sleep 5
2017-10-27 20:47:46,674 [salt.state       ][INFO    ][33049] Completed state [sleep 5] at time 20:47:46.673999 duration_in_ms=1.351
2017-10-27 20:47:46,675 [salt.state       ][INFO    ][33049] Running state [192.168.10.143] at time 20:47:46.674932
2017-10-27 20:47:46,675 [salt.state       ][INFO    ][33049] Executing state glusterfs.peered for 192.168.10.143
2017-10-27 20:47:46,675 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:46,695 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:46,789 [salt.state       ][INFO    ][33049] Host 192.168.10.143 already peered
2017-10-27 20:47:46,791 [salt.state       ][INFO    ][33049] Completed state [192.168.10.143] at time 20:47:46.791212 duration_in_ms=116.279
2017-10-27 20:47:46,802 [salt.state       ][INFO    ][33049] Running state [192.168.10.142] at time 20:47:46.801486
2017-10-27 20:47:46,803 [salt.state       ][INFO    ][33049] Executing state glusterfs.peered for 192.168.10.142
2017-10-27 20:47:46,803 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:46,824 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:46,915 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:46,935 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:47,029 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:47,059 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:47,144 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:47,169 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:47,265 [salt.state       ][INFO    ][33049] Peering with localhost is not needed
2017-10-27 20:47:47,265 [salt.state       ][INFO    ][33049] Completed state [192.168.10.142] at time 20:47:47.265267 duration_in_ms=463.781
2017-10-27 20:47:47,273 [salt.state       ][INFO    ][33049] Running state [192.168.10.141] at time 20:47:47.273156
2017-10-27 20:47:47,275 [salt.state       ][INFO    ][33049] Executing state glusterfs.peered for 192.168.10.141
2017-10-27 20:47:47,277 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:47,297 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:47,382 [salt.state       ][INFO    ][33049] Host 192.168.10.141 already peered
2017-10-27 20:47:47,383 [salt.state       ][INFO    ][33049] Completed state [192.168.10.141] at time 20:47:47.382676 duration_in_ms=109.519
2017-10-27 20:47:47,385 [salt.state       ][INFO    ][33049] Running state [glance] at time 20:47:47.385107
2017-10-27 20:47:47,386 [salt.state       ][INFO    ][33049] Executing state glusterfs.created for glance
2017-10-27 20:47:47,387 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:47,407 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:47,497 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:47,520 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:47,620 [salt.state       ][INFO    ][33049] Volume glance already exists and is started.
2017-10-27 20:47:47,621 [salt.state       ][INFO    ][33049] Completed state [glance] at time 20:47:47.620454 duration_in_ms=235.345
2017-10-27 20:47:47,628 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:47.628302
2017-10-27 20:47:47,629 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:47:47,629 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:47,725 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:47,726 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:47.725512 duration_in_ms=97.208
2017-10-27 20:47:47,727 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 20:47:47.727163
2017-10-27 20:47:47,728 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-27 20:47:47,729 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:47:47,830 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:47,831 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 20:47:47.830399 duration_in_ms=103.235
2017-10-27 20:47:47,832 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 20:47:47.831820
2017-10-27 20:47:47,832 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-27 20:47:47,833 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:47:47,928 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:47,929 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 20:47:47.928546 duration_in_ms=96.726
2017-10-27 20:47:47,930 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:47.929766
2017-10-27 20:47:47,930 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:47:47,931 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:48,025 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:48,026 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:48.026063 duration_in_ms=96.295
2017-10-27 20:47:48,027 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 20:47:48.027230
2017-10-27 20:47:48,028 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-27 20:47:48,029 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:47:48,123 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:48,123 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 20:47:48.123181 duration_in_ms=95.951
2017-10-27 20:47:48,126 [salt.state       ][INFO    ][33049] Running state [glance] at time 20:47:48.126015
2017-10-27 20:47:48,127 [salt.state       ][INFO    ][33049] Executing state glusterfs.started for glance
2017-10-27 20:47:48,127 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:48,148 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:48,229 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:48,249 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:48,345 [salt.state       ][INFO    ][33049] Volume glance is already started
2017-10-27 20:47:48,346 [salt.state       ][INFO    ][33049] Completed state [glance] at time 20:47:48.345411 duration_in_ms=219.394
2017-10-27 20:47:48,349 [salt.state       ][INFO    ][33049] Running state [keystone-keys] at time 20:47:48.349139
2017-10-27 20:47:48,351 [salt.state       ][INFO    ][33049] Executing state glusterfs.created for keystone-keys
2017-10-27 20:47:48,353 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:48,371 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:48,461 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:48,483 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:48,577 [salt.state       ][INFO    ][33049] Volume keystone-keys already exists and is started.
2017-10-27 20:47:48,579 [salt.state       ][INFO    ][33049] Completed state [keystone-keys] at time 20:47:48.578851 duration_in_ms=229.711
2017-10-27 20:47:48,587 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 20:47:48.586830
2017-10-27 20:47:48,587 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-27 20:47:48,589 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:47:48,690 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:48,691 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 20:47:48.690619 duration_in_ms=103.789
2017-10-27 20:47:48,691 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:48.691247
2017-10-27 20:47:48,692 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:47:48,692 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:48,804 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:48,805 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:48.804702 duration_in_ms=113.453
2017-10-27 20:47:48,807 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:48.807164
2017-10-27 20:47:48,808 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:47:48,809 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:48,907 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:48,907 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:48.907242 duration_in_ms=100.076
2017-10-27 20:47:48,909 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 20:47:48.908789
2017-10-27 20:47:48,909 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-27 20:47:48,911 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:47:49,011 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:49,012 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 20:47:49.011799 duration_in_ms=103.009
2017-10-27 20:47:49,013 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 20:47:49.013207
2017-10-27 20:47:49,014 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 20:47:49,015 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:47:49,115 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:49,116 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 20:47:49.115462 duration_in_ms=102.254
2017-10-27 20:47:49,120 [salt.state       ][INFO    ][33049] Running state [keystone-keys] at time 20:47:49.119902
2017-10-27 20:47:49,121 [salt.state       ][INFO    ][33049] Executing state glusterfs.started for keystone-keys
2017-10-27 20:47:49,121 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:49,145 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:49,236 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:49,257 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:49,353 [salt.state       ][INFO    ][33049] Volume keystone-keys is already started
2017-10-27 20:47:49,354 [salt.state       ][INFO    ][33049] Completed state [keystone-keys] at time 20:47:49.353480 duration_in_ms=233.577
2017-10-27 20:47:49,358 [salt.state       ][INFO    ][33049] Running state [nova_instances] at time 20:47:49.357502
2017-10-27 20:47:49,359 [salt.state       ][INFO    ][33049] Executing state glusterfs.created for nova_instances
2017-10-27 20:47:49,360 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:49,377 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:49,463 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:49,483 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:49,581 [salt.state       ][INFO    ][33049] Volume nova_instances already exists and is started.
2017-10-27 20:47:49,583 [salt.state       ][INFO    ][33049] Completed state [nova_instances] at time 20:47:49.582603 duration_in_ms=225.1
2017-10-27 20:47:49,592 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:49.592264
2017-10-27 20:47:49,593 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:47:49,593 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:49,687 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:49,689 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:49.687560 duration_in_ms=95.295
2017-10-27 20:47:49,690 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 20:47:49.690110
2017-10-27 20:47:49,691 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-27 20:47:49,692 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-27 20:47:49,796 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:49,796 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 20:47:49.796323 duration_in_ms=106.212
2017-10-27 20:47:49,799 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 20:47:49.799139
2017-10-27 20:47:49,800 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-27 20:47:49,801 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-27 20:47:49,893 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:49,894 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 20:47:49.893426 duration_in_ms=94.286
2017-10-27 20:47:49,895 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 20:47:49.895358
2017-10-27 20:47:49,896 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-27 20:47:49,897 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-27 20:47:49,998 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:49,999 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 20:47:49.998534 duration_in_ms=103.174
2017-10-27 20:47:49,1000 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:49.999915
2017-10-27 20:47:50,000 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:47:50,002 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:50,109 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:50,112 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:50.112038 duration_in_ms=112.123
2017-10-27 20:47:50,116 [salt.state       ][INFO    ][33049] Running state [nova_instances] at time 20:47:50.115445
2017-10-27 20:47:50,116 [salt.state       ][INFO    ][33049] Executing state glusterfs.started for nova_instances
2017-10-27 20:47:50,117 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:50,138 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:50,220 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:50,243 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:50,341 [salt.state       ][INFO    ][33049] Volume nova_instances is already started
2017-10-27 20:47:50,341 [salt.state       ][INFO    ][33049] Completed state [nova_instances] at time 20:47:50.341165 duration_in_ms=225.721
2017-10-27 20:47:50,348 [salt.state       ][INFO    ][33049] Running state [keystone-credential-keys] at time 20:47:50.347446
2017-10-27 20:47:50,348 [salt.state       ][INFO    ][33049] Executing state glusterfs.created for keystone-credential-keys
2017-10-27 20:47:50,349 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:50,373 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:50,452 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:50,473 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:50,567 [salt.state       ][INFO    ][33049] Volume keystone-credential-keys already exists and is started.
2017-10-27 20:47:50,568 [salt.state       ][INFO    ][33049] Completed state [keystone-credential-keys] at time 20:47:50.567696 duration_in_ms=220.249
2017-10-27 20:47:50,579 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 20:47:50.578903
2017-10-27 20:47:50,579 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 20:47:50,580 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:47:50,668 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:50,669 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 20:47:50.668714 duration_in_ms=89.809
2017-10-27 20:47:50,671 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:50.670816
2017-10-27 20:47:50,671 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:47:50,673 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:50,780 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:50,780 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:50.780304 duration_in_ms=109.487
2017-10-27 20:47:50,783 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 20:47:50.782871
2017-10-27 20:47:50,784 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-27 20:47:50,785 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:47:50,885 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:50,885 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 20:47:50.885279 duration_in_ms=102.408
2017-10-27 20:47:50,886 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:50.886350
2017-10-27 20:47:50,887 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:47:50,888 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:50,989 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:50,989 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:50.989355 duration_in_ms=103.005
2017-10-27 20:47:50,992 [salt.state       ][INFO    ][33049] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 20:47:50.992123
2017-10-27 20:47:50,993 [salt.state       ][INFO    ][33049] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-27 20:47:50,994 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:47:51,092 [salt.state       ][INFO    ][33049] unless execution succeeded
2017-10-27 20:47:51,094 [salt.state       ][INFO    ][33049] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 20:47:51.094293 duration_in_ms=102.17
2017-10-27 20:47:51,097 [salt.state       ][INFO    ][33049] Running state [keystone-credential-keys] at time 20:47:51.097405
2017-10-27 20:47:51,098 [salt.state       ][INFO    ][33049] Executing state glusterfs.started for keystone-credential-keys
2017-10-27 20:47:51,099 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:51,123 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:51,209 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:51,233 [salt.loaded.int.module.cmdmod][INFO    ][33049] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:51,329 [salt.state       ][INFO    ][33049] Volume keystone-credential-keys is already started
2017-10-27 20:47:51,329 [salt.state       ][INFO    ][33049] Completed state [keystone-credential-keys] at time 20:47:51.329281 duration_in_ms=231.875
2017-10-27 20:47:51,337 [salt.minion      ][INFO    ][33049] Returning information for job: 20171027204744693512
2017-10-27 20:48:00,872 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command test.ping with jid 20171027204800862008
2017-10-27 20:48:00,903 [salt.minion      ][INFO    ][33434] Starting a new job with PID 33434
2017-10-27 20:48:00,951 [salt.minion      ][INFO    ][33434] Returning information for job: 20171027204800862008
2017-10-27 20:48:01,085 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command cmd.run with jid 20171027204801071629
2017-10-27 20:48:01,108 [salt.minion      ][INFO    ][33439] Starting a new job with PID 33439
2017-10-27 20:48:01,116 [salt.loaded.int.module.cmdmod][INFO    ][33439] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-27 20:48:01,307 [salt.minion      ][INFO    ][33439] Returning information for job: 20171027204801071629
2017-10-27 20:48:08,146 [salt.utils.schedule][INFO    ][24305] Running scheduled job: __mine_interval
2017-10-27 21:12:43,260 [salt.minion      ][INFO    ][24305] User sudo_ubuntu Executing command cp.push_dir with jid 20171027211243247102
2017-10-27 21:12:43,289 [salt.minion      ][INFO    ][33652] Starting a new job with PID 33652
