2017-10-30 09:28:47,281 [salt.cli.daemons ][WARNING ][2450] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-30 09:29:10,301 [salt.state       ][ERROR   ][3982] No contents found in top file
2017-10-30 09:31:51,899 [salt.utils.parsers][WARNING ][2450] Minion received a SIGTERM. Exiting.
2017-10-30 09:36:16,478 [salt.cli.daemons ][WARNING ][3599] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-30 09:38:24,370 [salt.loaded.int.module.cmdmod][ERROR   ][11778] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-10-30 09:38:24,370 [salt.loaded.int.module.cmdmod][ERROR   ][11778] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-10-30 09:38:24,371 [salt.loaded.int.module.cmdmod][ERROR   ][11778] retcode: 1
2017-10-30 09:38:24,371 [salt.state       ][ERROR   ][11778] {'pid': 16705, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-10-30 09:38:51,267 [py.warnings      ][WARNING ][16782] /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-30 09:39:13,549 [salt.loaded.int.module.cmdmod][ERROR   ][16782] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-30 09:39:13,549 [salt.loaded.int.module.cmdmod][ERROR   ][16782] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-30 09:39:17,823 [salt.loaded.int.module.cmdmod][ERROR   ][16782] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-30 09:39:17,824 [salt.loaded.int.module.cmdmod][ERROR   ][16782] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-30 09:39:21,980 [salt.loaded.int.module.cmdmod][ERROR   ][16782] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-30 09:39:21,981 [salt.loaded.int.module.cmdmod][ERROR   ][16782] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-30 09:39:26,162 [salt.loaded.int.module.cmdmod][ERROR   ][16782] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-30 09:39:26,162 [salt.loaded.int.module.cmdmod][ERROR   ][16782] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-30 09:39:30,422 [salt.loaded.int.module.cmdmod][ERROR   ][16782] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-30 09:39:30,422 [salt.loaded.int.module.cmdmod][ERROR   ][16782] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-30 09:39:33,878 [salt.loaded.int.module.cmdmod][ERROR   ][16782] 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-30 09:39:36,435 [salt.loaded.int.module.cmdmod][INFO    ][24609] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-30 09:39:36,443 [salt.loaded.int.module.cmdmod][INFO    ][24609] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-30 09:39:36,452 [salt.loaded.int.module.cmdmod][INFO    ][24609] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-10-30 09:39:36,460 [salt.utils.parsers][WARNING ][3599] Minion received a SIGTERM. Exiting.
2017-10-30 09:39:36,774 [salt.cli.daemons ][INFO    ][24696] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-10-30 09:39:37,411 [salt.minion      ][INFO    ][24696] Creating minion process manager
2017-10-30 09:39:37,411 [salt.cli.daemons ][WARNING ][24696] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-30 09:39:37,412 [salt.cli.daemons ][INFO    ][24696] The Salt Minion is starting up
2017-10-30 09:39:37,412 [salt.minion      ][INFO    ][24696] Minion is starting as user 'root'
2017-10-30 09:39:37,412 [salt.utils.event ][INFO    ][24696] Starting pull socket on /var/run/salt/minion/minion_event_0fd62c7a6e_pull.ipc
2017-10-30 09:39:38,504 [salt.loaded.int.module.cmdmod][INFO    ][24696] Executing command ['date', '+%z'] in directory '/root'
2017-10-30 09:39:38,514 [salt.utils.schedule][INFO    ][24696] Updating job settings for scheduled job: __mine_interval
2017-10-30 09:39:38,517 [salt.minion      ][INFO    ][24696] Added mine.update to scheduler
2017-10-30 09:39:38,547 [salt.minion      ][INFO    ][24696] Minion is ready to receive requests!
2017-10-30 09:39:39,548 [salt.utils.schedule][INFO    ][24696] Running scheduled job: __mine_interval
2017-10-30 09:39:40,038 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171030093940029470
2017-10-30 09:39:40,050 [salt.minion      ][INFO    ][24822] Starting a new job with PID 24822
2017-10-30 09:39:42,313 [salt.state       ][INFO    ][24822] Loading fresh modules for state activity
2017-10-30 09:39:42,340 [salt.state       ][ERROR   ][24822] No contents found in top file
2017-10-30 09:39:42,341 [salt.utils.extmods][INFO    ][24822] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-30 09:39:42,344 [salt.utils.extmods][INFO    ][24822] Syncing beacons for environment 'base'
2017-10-30 09:39:42,344 [salt.utils.extmods][INFO    ][24822] Loading cache from salt://_beacons, for base)
2017-10-30 09:39:42,344 [salt.fileclient  ][INFO    ][24822] Caching directory '_beacons/' for environment 'base'
2017-10-30 09:39:42,375 [salt.utils.extmods][INFO    ][24822] Syncing modules for environment 'base'
2017-10-30 09:39:42,376 [salt.utils.extmods][INFO    ][24822] Loading cache from salt://_modules, for base)
2017-10-30 09:39:42,376 [salt.fileclient  ][INFO    ][24822] Caching directory '_modules/' for environment 'base'
2017-10-30 09:39:42,420 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-30 09:39:42,430 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-30 09:39:42,442 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-30 09:39:42,453 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-30 09:39:42,464 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-30 09:39:42,473 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-30 09:39:42,485 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-30 09:39:42,496 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-30 09:39:42,505 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-30 09:39:42,516 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-30 09:39:42,711 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-30 09:39:42,721 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-30 09:39:42,732 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-30 09:39:42,741 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-30 09:39:42,751 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-30 09:39:42,761 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-30 09:39:42,772 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-30 09:39:42,781 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-30 09:39:42,791 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-30 09:39:42,801 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-30 09:39:42,819 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-30 09:39:42,829 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-30 09:39:42,841 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-30 09:39:42,850 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-30 09:39:42,861 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-30 09:39:42,873 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-30 09:39:42,884 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-30 09:39:42,905 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-30 09:39:42,917 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-30 09:39:42,928 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-30 09:39:42,937 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-30 09:39:42,948 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-30 09:39:42,952 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-30 09:39:42,952 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-30 09:39:42,953 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-30 09:39:42,953 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-30 09:39:42,953 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-30 09:39:42,953 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-30 09:39:42,954 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-30 09:39:42,954 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-30 09:39:42,954 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-30 09:39:42,954 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-30 09:39:42,955 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-30 09:39:42,955 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-30 09:39:42,955 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-30 09:39:42,955 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-30 09:39:42,956 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-30 09:39:42,956 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-30 09:39:42,956 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-30 09:39:42,956 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-30 09:39:42,957 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-30 09:39:42,957 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-30 09:39:42,957 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-30 09:39:42,957 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-30 09:39:42,958 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-30 09:39:42,958 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-30 09:39:42,958 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-30 09:39:42,959 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-30 09:39:42,959 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-30 09:39:42,959 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-30 09:39:42,959 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-30 09:39:42,960 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-30 09:39:42,960 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-30 09:39:42,960 [salt.utils.extmods][INFO    ][24822] 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-30 09:39:42,960 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-30 09:39:42,960 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-30 09:39:42,966 [salt.utils.extmods][INFO    ][24822] Syncing states for environment 'base'
2017-10-30 09:39:42,966 [salt.utils.extmods][INFO    ][24822] Loading cache from salt://_states, for base)
2017-10-30 09:39:42,966 [salt.fileclient  ][INFO    ][24822] Caching directory '_states/' for environment 'base'
2017-10-30 09:39:43,001 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-30 09:39:43,012 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-30 09:39:43,022 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-30 09:39:43,032 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-30 09:39:43,043 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-30 09:39:43,052 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-30 09:39:43,061 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-30 09:39:43,072 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-30 09:39:43,081 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-30 09:39:43,091 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-30 09:39:43,100 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-30 09:39:43,110 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-30 09:39:43,121 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-30 09:39:43,132 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-30 09:39:43,140 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-30 09:39:43,150 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-30 09:39:43,158 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-30 09:39:43,168 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-30 09:39:43,180 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-30 09:39:43,189 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-30 09:39:43,199 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-30 09:39:43,209 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-30 09:39:43,220 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-30 09:39:43,236 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-30 09:39:43,246 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-30 09:39:43,256 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-30 09:39:43,266 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-30 09:39:43,275 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-30 09:39:43,284 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-30 09:39:43,288 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-30 09:39:43,288 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-30 09:39:43,288 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-30 09:39:43,288 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-30 09:39:43,289 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-30 09:39:43,289 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-30 09:39:43,289 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-30 09:39:43,289 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-30 09:39:43,290 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-30 09:39:43,290 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-30 09:39:43,290 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-30 09:39:43,290 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-30 09:39:43,291 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-30 09:39:43,291 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-30 09:39:43,291 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-30 09:39:43,291 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-30 09:39:43,292 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-30 09:39:43,292 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-30 09:39:43,292 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-30 09:39:43,292 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-30 09:39:43,292 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-30 09:39:43,293 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-30 09:39:43,293 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-30 09:39:43,293 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-30 09:39:43,293 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-30 09:39:43,294 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-30 09:39:43,294 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-30 09:39:43,294 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-30 09:39:43,294 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-30 09:39:43,295 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-30 09:39:43,297 [salt.utils.extmods][INFO    ][24822] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-30 09:39:43,300 [salt.utils.extmods][INFO    ][24822] Syncing sdb for environment 'base'
2017-10-30 09:39:43,300 [salt.utils.extmods][INFO    ][24822] Loading cache from salt://_sdb, for base)
2017-10-30 09:39:43,300 [salt.fileclient  ][INFO    ][24822] Caching directory '_sdb/' for environment 'base'
2017-10-30 09:39:43,331 [salt.utils.extmods][INFO    ][24822] Syncing grains for environment 'base'
2017-10-30 09:39:43,332 [salt.utils.extmods][INFO    ][24822] Loading cache from salt://_grains, for base)
2017-10-30 09:39:43,332 [salt.fileclient  ][INFO    ][24822] Caching directory '_grains/' for environment 'base'
2017-10-30 09:39:43,364 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-30 09:39:43,372 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-30 09:39:43,381 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-30 09:39:43,391 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-30 09:39:43,400 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-30 09:39:43,410 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-30 09:39:43,420 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-30 09:39:43,430 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-30 09:39:43,439 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-30 09:39:43,447 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-30 09:39:43,455 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-30 09:39:43,464 [salt.fileclient  ][INFO    ][24822] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-30 09:39:43,468 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-30 09:39:43,468 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-30 09:39:43,468 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-30 09:39:43,468 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-30 09:39:43,469 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-30 09:39:43,469 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-30 09:39:43,469 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-30 09:39:43,469 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-30 09:39:43,470 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-30 09:39:43,470 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-30 09:39:43,470 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-30 09:39:43,470 [salt.utils.extmods][INFO    ][24822] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-30 09:39:43,472 [salt.utils.extmods][INFO    ][24822] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-30 09:39:43,474 [salt.utils.extmods][INFO    ][24822] Syncing renderers for environment 'base'
2017-10-30 09:39:43,474 [salt.utils.extmods][INFO    ][24822] Loading cache from salt://_renderers, for base)
2017-10-30 09:39:43,475 [salt.fileclient  ][INFO    ][24822] Caching directory '_renderers/' for environment 'base'
2017-10-30 09:39:43,506 [salt.utils.extmods][INFO    ][24822] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-30 09:39:43,508 [salt.utils.extmods][INFO    ][24822] Syncing returners for environment 'base'
2017-10-30 09:39:43,508 [salt.utils.extmods][INFO    ][24822] Loading cache from salt://_returners, for base)
2017-10-30 09:39:43,509 [salt.fileclient  ][INFO    ][24822] Caching directory '_returners/' for environment 'base'
2017-10-30 09:39:43,536 [salt.utils.extmods][INFO    ][24822] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-30 09:39:43,539 [salt.utils.extmods][INFO    ][24822] Syncing output for environment 'base'
2017-10-30 09:39:43,539 [salt.utils.extmods][INFO    ][24822] Loading cache from salt://_output, for base)
2017-10-30 09:39:43,539 [salt.fileclient  ][INFO    ][24822] Caching directory '_output/' for environment 'base'
2017-10-30 09:39:43,567 [salt.utils.extmods][INFO    ][24822] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-30 09:39:43,570 [salt.utils.extmods][INFO    ][24822] Syncing utils for environment 'base'
2017-10-30 09:39:43,570 [salt.utils.extmods][INFO    ][24822] Loading cache from salt://_utils, for base)
2017-10-30 09:39:43,570 [salt.fileclient  ][INFO    ][24822] Caching directory '_utils/' for environment 'base'
2017-10-30 09:39:43,596 [salt.utils.extmods][INFO    ][24822] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-30 09:39:43,599 [salt.utils.extmods][INFO    ][24822] Syncing log_handlers for environment 'base'
2017-10-30 09:39:43,599 [salt.utils.extmods][INFO    ][24822] Loading cache from salt://_log_handlers, for base)
2017-10-30 09:39:43,599 [salt.fileclient  ][INFO    ][24822] Caching directory '_log_handlers/' for environment 'base'
2017-10-30 09:39:43,626 [salt.utils.extmods][INFO    ][24822] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-30 09:39:43,629 [salt.utils.extmods][INFO    ][24822] Syncing proxy for environment 'base'
2017-10-30 09:39:43,629 [salt.utils.extmods][INFO    ][24822] Loading cache from salt://_proxy, for base)
2017-10-30 09:39:43,629 [salt.fileclient  ][INFO    ][24822] Caching directory '_proxy/' for environment 'base'
2017-10-30 09:39:43,655 [salt.utils.extmods][INFO    ][24822] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-30 09:39:43,658 [salt.utils.extmods][INFO    ][24822] Syncing engines for environment 'base'
2017-10-30 09:39:43,658 [salt.utils.extmods][INFO    ][24822] Loading cache from salt://_engines, for base)
2017-10-30 09:39:43,658 [salt.fileclient  ][INFO    ][24822] Caching directory '_engines/' for environment 'base'
2017-10-30 09:39:43,688 [salt.minion      ][INFO    ][24822] Returning information for job: 20171030093940029470
2017-10-30 09:40:01,072 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command state.sls with jid 20171030094001063456
2017-10-30 09:40:01,082 [salt.minion      ][INFO    ][24943] Starting a new job with PID 24943
2017-10-30 09:40:03,399 [salt.state       ][INFO    ][24943] Loading fresh modules for state activity
2017-10-30 09:40:03,432 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-30 09:40:03,451 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-30 09:40:03,509 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-30 09:40:03,590 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-30 09:40:03,604 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-30 09:40:03,631 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-30 09:40:03,690 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-30 09:40:03,708 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-30 09:40:03,781 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-30 09:40:03,800 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-30 09:40:03,818 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-30 09:40:03,837 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-30 09:40:03,847 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-30 09:40:03,868 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-30 09:40:03,889 [py.warnings      ][WARNING ][24943] /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-30 09:40:03,889 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'salt-minion --version' in directory '/root'
2017-10-30 09:40:04,150 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-30 09:40:04,167 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-30 09:40:04,177 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-30 09:40:04,189 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-30 09:40:04,241 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-30 09:40:04,280 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-30 09:40:04,357 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-30 09:40:04,385 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-30 09:40:04,457 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-30 09:40:04,483 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-30 09:40:04,539 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-30 09:40:04,557 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-30 09:40:04,574 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-30 09:40:04,590 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-30 09:40:04,598 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-30 09:40:04,619 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-30 09:40:04,637 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'salt-minion --version' in directory '/root'
2017-10-30 09:40:04,893 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-30 09:40:04,908 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-30 09:40:04,920 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-30 09:40:04,933 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-30 09:40:04,981 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-30 09:40:05,015 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-30 09:40:05,090 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-30 09:40:05,162 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-30 09:40:05,530 [salt.state       ][INFO    ][24943] Running state [salt-minion] at time 09:40:05.529478
2017-10-30 09:40:05,530 [salt.state       ][INFO    ][24943] Executing state pkg.installed for salt-minion
2017-10-30 09:40:05,530 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-30 09:40:05,780 [salt.state       ][INFO    ][24943] Package salt-minion is already installed
2017-10-30 09:40:05,780 [salt.state       ][INFO    ][24943] Completed state [salt-minion] at time 09:40:05.779944 duration_in_ms=250.465
2017-10-30 09:40:05,780 [salt.state       ][INFO    ][24943] Running state [salt_minion_dependency_packages] at time 09:40:05.780219
2017-10-30 09:40:05,780 [salt.state       ][INFO    ][24943] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-30 09:40:05,784 [salt.state       ][INFO    ][24943] All specified packages are already installed
2017-10-30 09:40:05,785 [salt.state       ][INFO    ][24943] Completed state [salt_minion_dependency_packages] at time 09:40:05.784488 duration_in_ms=4.269
2017-10-30 09:40:05,786 [salt.state       ][INFO    ][24943] Running state [/etc/salt/minion.d/minion.conf] at time 09:40:05.786136
2017-10-30 09:40:05,786 [salt.state       ][INFO    ][24943] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-30 09:40:05,806 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-30 09:40:05,872 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-30 09:40:05,924 [salt.fileclient  ][INFO    ][24943] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-30 09:40:05,972 [salt.state       ][INFO    ][24943] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-30 09:40:05,972 [salt.state       ][INFO    ][24943] Completed state [/etc/salt/minion.d/minion.conf] at time 09:40:05.971866 duration_in_ms=185.73
2017-10-30 09:40:05,972 [salt.state       ][INFO    ][24943] Running state [/etc/salt/minion.d/_virt.conf] at time 09:40:05.972240
2017-10-30 09:40:05,972 [salt.state       ][INFO    ][24943] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-30 09:40:05,973 [salt.state       ][INFO    ][24943] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-30 09:40:05,973 [salt.state       ][INFO    ][24943] Completed state [/etc/salt/minion.d/_virt.conf] at time 09:40:05.973266 duration_in_ms=1.026
2017-10-30 09:40:05,975 [salt.state       ][INFO    ][24943] Running state [salt-minion] at time 09:40:05.974955
2017-10-30 09:40:05,975 [salt.state       ][INFO    ][24943] Executing state service.running for salt-minion
2017-10-30 09:40:05,976 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-30 09:40:05,988 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-30 09:40:05,993 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-30 09:40:05,999 [salt.state       ][INFO    ][24943] The service salt-minion is already running
2017-10-30 09:40:05,999 [salt.state       ][INFO    ][24943] Completed state [salt-minion] at time 09:40:05.999190 duration_in_ms=24.235
2017-10-30 09:40:06,001 [salt.state       ][INFO    ][24943] Running state [/etc/salt/grains.d] at time 09:40:06.000620
2017-10-30 09:40:06,001 [salt.state       ][INFO    ][24943] Executing state file.directory for /etc/salt/grains.d
2017-10-30 09:40:06,001 [salt.state       ][INFO    ][24943] Directory /etc/salt/grains.d is in the correct state
2017-10-30 09:40:06,002 [salt.state       ][INFO    ][24943] Completed state [/etc/salt/grains.d] at time 09:40:06.001616 duration_in_ms=0.996
2017-10-30 09:40:06,002 [salt.state       ][INFO    ][24943] Running state [/etc/salt/grains] at time 09:40:06.002185
2017-10-30 09:40:06,002 [salt.state       ][INFO    ][24943] Executing state file.managed for /etc/salt/grains
2017-10-30 09:40:06,003 [salt.state       ][INFO    ][24943] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-30 09:40:06,003 [salt.state       ][INFO    ][24943] Completed state [/etc/salt/grains] at time 09:40:06.002995 duration_in_ms=0.81
2017-10-30 09:40:06,003 [salt.state       ][INFO    ][24943] Running state [/etc/salt/grains.d/placeholder] at time 09:40:06.003351
2017-10-30 09:40:06,004 [salt.state       ][INFO    ][24943] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-30 09:40:06,004 [salt.state       ][INFO    ][24943] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-30 09:40:06,004 [salt.state       ][INFO    ][24943] Completed state [/etc/salt/grains.d/placeholder] at time 09:40:06.004077 duration_in_ms=0.726
2017-10-30 09:40:06,004 [salt.state       ][INFO    ][24943] Running state [/etc/salt/grains.d/sphinx] at time 09:40:06.004434
2017-10-30 09:40:06,005 [salt.state       ][INFO    ][24943] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-30 09:40:06,006 [salt.state       ][INFO    ][24943] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.141
               - 192.168.11.2
-              - 192.168.122.1
         system:
           name: System
           param:

2017-10-30 09:40:06,006 [salt.state       ][INFO    ][24943] Completed state [/etc/salt/grains.d/sphinx] at time 09:40:06.006165 duration_in_ms=1.73
2017-10-30 09:40:06,007 [salt.state       ][INFO    ][24943] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:40:06.006960
2017-10-30 09:40:06,007 [salt.state       ][INFO    ][24943] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-30 09:40:06,007 [salt.state       ][INFO    ][24943] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-30 09:40:06,008 [salt.state       ][INFO    ][24943] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:40:06.007698 duration_in_ms=0.738
2017-10-30 09:40:06,008 [salt.state       ][INFO    ][24943] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:40:06.008089
2017-10-30 09:40:06,008 [salt.state       ][INFO    ][24943] 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-30 09:40:06,009 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-10-30 09:40:06,084 [salt.state       ][INFO    ][24943] {'pid': 24991, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-30 09:40:06,085 [salt.state       ][INFO    ][24943] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:40:06.084647 duration_in_ms=76.558
2017-10-30 09:40:06,085 [salt.state       ][INFO    ][24943] Running state [/etc/salt/grains.d/dns_records] at time 09:40:06.085263
2017-10-30 09:40:06,086 [salt.state       ][INFO    ][24943] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-30 09:40:06,087 [salt.state       ][INFO    ][24943] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-30 09:40:06,087 [salt.state       ][INFO    ][24943] Completed state [/etc/salt/grains.d/dns_records] at time 09:40:06.086825 duration_in_ms=1.561
2017-10-30 09:40:06,088 [salt.state       ][INFO    ][24943] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:40:06.087634
2017-10-30 09:40:06,088 [salt.state       ][INFO    ][24943] 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-30 09:40:06,088 [salt.state       ][INFO    ][24943] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-30 09:40:06,088 [salt.state       ][INFO    ][24943] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:40:06.088251 duration_in_ms=0.617
2017-10-30 09:40:06,089 [salt.state       ][INFO    ][24943] Running state [/etc/salt/grains.d/salt] at time 09:40:06.088604
2017-10-30 09:40:06,089 [salt.state       ][INFO    ][24943] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-30 09:40:06,090 [salt.state       ][INFO    ][24943] File /etc/salt/grains.d/salt is in the correct state
2017-10-30 09:40:06,090 [salt.state       ][INFO    ][24943] Completed state [/etc/salt/grains.d/salt] at time 09:40:06.089701 duration_in_ms=1.097
2017-10-30 09:40:06,090 [salt.state       ][INFO    ][24943] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:40:06.090452
2017-10-30 09:40:06,091 [salt.state       ][INFO    ][24943] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-30 09:40:06,091 [salt.state       ][INFO    ][24943] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-30 09:40:06,091 [salt.state       ][INFO    ][24943] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:40:06.091093 duration_in_ms=0.641
2017-10-30 09:40:06,093 [salt.state       ][INFO    ][24943] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:40:06.092676
2017-10-30 09:40:06,093 [salt.state       ][INFO    ][24943] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-30 09:40:06,093 [salt.state       ][INFO    ][24943] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-30 09:40:06,093 [salt.state       ][INFO    ][24943] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:40:06.093267 duration_in_ms=0.591
2017-10-30 09:40:06,093 [salt.state       ][INFO    ][24943] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:40:06.093419
2017-10-30 09:40:06,094 [salt.state       ][INFO    ][24943] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-30 09:40:06,095 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-10-30 09:40:06,101 [salt.state       ][INFO    ][24943] {'pid': 24993, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-30 09:40:06,101 [salt.state       ][INFO    ][24943] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:40:06.101436 duration_in_ms=8.016
2017-10-30 09:40:06,102 [salt.state       ][INFO    ][24943] Running state [mine.update] at time 09:40:06.102102
2017-10-30 09:40:06,102 [salt.state       ][INFO    ][24943] Executing state module.wait for mine.update
2017-10-30 09:40:06,103 [salt.state       ][INFO    ][24943] No changes made for mine.update
2017-10-30 09:40:06,103 [salt.state       ][INFO    ][24943] Completed state [mine.update] at time 09:40:06.102748 duration_in_ms=0.646
2017-10-30 09:40:06,103 [salt.state       ][INFO    ][24943] Running state [mine.update] at time 09:40:06.102942
2017-10-30 09:40:06,103 [salt.state       ][INFO    ][24943] Executing state module.mod_watch for mine.update
2017-10-30 09:40:06,617 [salt.state       ][INFO    ][24943] {'ret': True}
2017-10-30 09:40:06,618 [salt.state       ][INFO    ][24943] Completed state [mine.update] at time 09:40:06.617584 duration_in_ms=514.641
2017-10-30 09:40:06,618 [salt.state       ][INFO    ][24943] Running state [ca-certificates] at time 09:40:06.617852
2017-10-30 09:40:06,618 [salt.state       ][INFO    ][24943] Executing state pkg.installed for ca-certificates
2017-10-30 09:40:06,622 [salt.state       ][INFO    ][24943] Package ca-certificates is already installed
2017-10-30 09:40:06,623 [salt.state       ][INFO    ][24943] Completed state [ca-certificates] at time 09:40:06.622681 duration_in_ms=4.829
2017-10-30 09:40:06,623 [salt.state       ][INFO    ][24943] Running state [update-ca-certificates] at time 09:40:06.623376
2017-10-30 09:40:06,624 [salt.state       ][INFO    ][24943] Executing state cmd.wait for update-ca-certificates
2017-10-30 09:40:06,624 [salt.state       ][INFO    ][24943] No changes made for update-ca-certificates
2017-10-30 09:40:06,624 [salt.state       ][INFO    ][24943] Completed state [update-ca-certificates] at time 09:40:06.624015 duration_in_ms=0.639
2017-10-30 09:40:06,624 [salt.state       ][INFO    ][24943] Running state [libvirt-dev] at time 09:40:06.624218
2017-10-30 09:40:06,624 [salt.state       ][INFO    ][24943] Executing state pkg.installed for libvirt-dev
2017-10-30 09:40:06,628 [salt.state       ][INFO    ][24943] Package libvirt-dev is already installed
2017-10-30 09:40:06,629 [salt.state       ][INFO    ][24943] Completed state [libvirt-dev] at time 09:40:06.628498 duration_in_ms=4.28
2017-10-30 09:40:06,629 [salt.state       ][INFO    ][24943] Running state [pkg-config] at time 09:40:06.628708
2017-10-30 09:40:06,629 [salt.state       ][INFO    ][24943] Executing state pkg.installed for pkg-config
2017-10-30 09:40:06,633 [salt.state       ][INFO    ][24943] Package pkg-config is already installed
2017-10-30 09:40:06,633 [salt.state       ][INFO    ][24943] Completed state [pkg-config] at time 09:40:06.633019 duration_in_ms=4.311
2017-10-30 09:40:06,633 [salt.state       ][INFO    ][24943] Running state [virtng.init] at time 09:40:06.633234
2017-10-30 09:40:06,633 [salt.state       ][INFO    ][24943] Executing state module.run for virtng.init
2017-10-30 09:40:06,704 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command ['git', '--version'] in directory '/root'
2017-10-30 09:40:06,785 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-30 09:40:06,802 [salt.state       ][INFO    ][24943] unless execution succeeded
2017-10-30 09:40:06,802 [salt.state       ][INFO    ][24943] Completed state [virtng.init] at time 09:40:06.802148 duration_in_ms=168.913
2017-10-30 09:40:06,802 [salt.state       ][INFO    ][24943] Running state [virt.set_autostart] at time 09:40:06.802423
2017-10-30 09:40:06,803 [salt.state       ][INFO    ][24943] Executing state module.run for virt.set_autostart
2017-10-30 09:40:06,805 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-30 09:40:06,821 [salt.state       ][INFO    ][24943] unless execution succeeded
2017-10-30 09:40:06,821 [salt.state       ][INFO    ][24943] Completed state [virt.set_autostart] at time 09:40:06.821173 duration_in_ms=18.75
2017-10-30 09:40:06,821 [salt.state       ][INFO    ][24943] Running state [virtng.init] at time 09:40:06.821433
2017-10-30 09:40:06,822 [salt.state       ][INFO    ][24943] Executing state module.run for virtng.init
2017-10-30 09:40:06,824 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-30 09:40:06,841 [salt.state       ][INFO    ][24943] unless execution succeeded
2017-10-30 09:40:06,841 [salt.state       ][INFO    ][24943] Completed state [virtng.init] at time 09:40:06.840958 duration_in_ms=19.524
2017-10-30 09:40:06,841 [salt.state       ][INFO    ][24943] Running state [virt.set_autostart] at time 09:40:06.841232
2017-10-30 09:40:06,841 [salt.state       ][INFO    ][24943] Executing state module.run for virt.set_autostart
2017-10-30 09:40:06,844 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-30 09:40:06,861 [salt.state       ][INFO    ][24943] unless execution succeeded
2017-10-30 09:40:06,861 [salt.state       ][INFO    ][24943] Completed state [virt.set_autostart] at time 09:40:06.861099 duration_in_ms=19.867
2017-10-30 09:40:06,861 [salt.state       ][INFO    ][24943] Running state [virtng.init] at time 09:40:06.861381
2017-10-30 09:40:06,862 [salt.state       ][INFO    ][24943] Executing state module.run for virtng.init
2017-10-30 09:40:06,864 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-30 09:40:06,881 [salt.state       ][INFO    ][24943] unless execution succeeded
2017-10-30 09:40:06,881 [salt.state       ][INFO    ][24943] Completed state [virtng.init] at time 09:40:06.881424 duration_in_ms=20.042
2017-10-30 09:40:06,882 [salt.state       ][INFO    ][24943] Running state [virt.set_autostart] at time 09:40:06.881713
2017-10-30 09:40:06,882 [salt.state       ][INFO    ][24943] Executing state module.run for virt.set_autostart
2017-10-30 09:40:06,885 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-30 09:40:06,901 [salt.state       ][INFO    ][24943] unless execution succeeded
2017-10-30 09:40:06,902 [salt.state       ][INFO    ][24943] Completed state [virt.set_autostart] at time 09:40:06.901483 duration_in_ms=19.769
2017-10-30 09:40:06,902 [salt.state       ][INFO    ][24943] Running state [virtng.init] at time 09:40:06.901761
2017-10-30 09:40:06,902 [salt.state       ][INFO    ][24943] Executing state module.run for virtng.init
2017-10-30 09:40:06,905 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-30 09:40:06,921 [salt.state       ][INFO    ][24943] unless execution succeeded
2017-10-30 09:40:06,921 [salt.state       ][INFO    ][24943] Completed state [virtng.init] at time 09:40:06.921294 duration_in_ms=19.532
2017-10-30 09:40:06,922 [salt.state       ][INFO    ][24943] Running state [virt.set_autostart] at time 09:40:06.921580
2017-10-30 09:40:06,922 [salt.state       ][INFO    ][24943] Executing state module.run for virt.set_autostart
2017-10-30 09:40:06,925 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-30 09:40:06,941 [salt.state       ][INFO    ][24943] unless execution succeeded
2017-10-30 09:40:06,942 [salt.state       ][INFO    ][24943] Completed state [virt.set_autostart] at time 09:40:06.941659 duration_in_ms=20.077
2017-10-30 09:40:06,942 [salt.state       ][INFO    ][24943] Running state [virtng.init] at time 09:40:06.941936
2017-10-30 09:40:06,942 [salt.state       ][INFO    ][24943] Executing state module.run for virtng.init
2017-10-30 09:40:06,945 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-30 09:40:06,962 [salt.state       ][INFO    ][24943] unless execution succeeded
2017-10-30 09:40:06,962 [salt.state       ][INFO    ][24943] Completed state [virtng.init] at time 09:40:06.962341 duration_in_ms=20.404
2017-10-30 09:40:06,963 [salt.state       ][INFO    ][24943] Running state [virt.set_autostart] at time 09:40:06.962645
2017-10-30 09:40:06,963 [salt.state       ][INFO    ][24943] Executing state module.run for virt.set_autostart
2017-10-30 09:40:06,966 [salt.loaded.int.module.cmdmod][INFO    ][24943] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-30 09:40:06,983 [salt.state       ][INFO    ][24943] unless execution succeeded
2017-10-30 09:40:06,983 [salt.state       ][INFO    ][24943] Completed state [virt.set_autostart] at time 09:40:06.983297 duration_in_ms=20.651
2017-10-30 09:40:06,986 [salt.minion      ][INFO    ][24943] Returning information for job: 20171030094001063456
2017-10-30 09:40:09,945 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command pillar.get with jid 20171030094009931793
2017-10-30 09:40:09,956 [salt.minion      ][INFO    ][25046] Starting a new job with PID 25046
2017-10-30 09:40:09,959 [salt.minion      ][INFO    ][25046] Returning information for job: 20171030094009931793
2017-10-30 09:40:35,150 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171030094035138274
2017-10-30 09:40:35,162 [salt.minion      ][INFO    ][25053] Starting a new job with PID 25053
2017-10-30 09:40:39,487 [salt.state       ][INFO    ][25053] Loading fresh modules for state activity
2017-10-30 09:40:40,093 [salt.state       ][ERROR   ][25053] No contents found in top file
2017-10-30 09:40:40,093 [salt.utils.extmods][INFO    ][25053] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-30 09:40:40,097 [salt.utils.extmods][INFO    ][25053] Syncing beacons for environment 'base'
2017-10-30 09:40:40,097 [salt.utils.extmods][INFO    ][25053] Loading cache from salt://_beacons, for base)
2017-10-30 09:40:40,097 [salt.fileclient  ][INFO    ][25053] Caching directory '_beacons/' for environment 'base'
2017-10-30 09:40:40,130 [salt.utils.extmods][INFO    ][25053] Syncing modules for environment 'base'
2017-10-30 09:40:40,131 [salt.utils.extmods][INFO    ][25053] Loading cache from salt://_modules, for base)
2017-10-30 09:40:40,131 [salt.fileclient  ][INFO    ][25053] Caching directory '_modules/' for environment 'base'
2017-10-30 09:40:40,199 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-30 09:40:40,220 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-30 09:40:40,246 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-30 09:40:40,262 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-30 09:40:40,278 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-30 09:40:40,310 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-30 09:40:40,328 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-30 09:40:40,366 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-30 09:40:40,380 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-30 09:40:40,394 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-30 09:40:40,404 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-30 09:40:40,416 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-30 09:40:40,450 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-30 09:40:40,462 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-30 09:40:40,483 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-30 09:40:40,496 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-30 09:40:40,507 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-30 09:40:40,522 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-30 09:40:40,540 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-30 09:40:40,555 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-30 09:40:40,575 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-30 09:40:40,587 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-30 09:40:40,607 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-30 09:40:40,666 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-30 09:40:40,722 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-30 09:40:40,733 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-30 09:40:40,750 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-30 09:40:40,771 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-30 09:40:40,792 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-30 09:40:40,804 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-30 09:40:40,819 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-30 09:40:40,833 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-30 09:40:40,838 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-30 09:40:40,838 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-30 09:40:40,838 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-30 09:40:40,838 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-30 09:40:40,839 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-30 09:40:40,839 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-30 09:40:40,840 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-30 09:40:40,840 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-30 09:40:40,840 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-30 09:40:40,840 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-30 09:40:40,841 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-30 09:40:40,841 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-30 09:40:40,841 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-30 09:40:40,841 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-30 09:40:40,842 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-30 09:40:40,842 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-30 09:40:40,842 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-30 09:40:40,842 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-30 09:40:40,843 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-30 09:40:40,843 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-30 09:40:40,843 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-30 09:40:40,844 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-30 09:40:40,844 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-30 09:40:40,844 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-30 09:40:40,845 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-30 09:40:40,845 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-30 09:40:40,845 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-30 09:40:40,846 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-30 09:40:40,846 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-30 09:40:40,846 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-30 09:40:40,846 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-30 09:40:40,847 [salt.utils.extmods][INFO    ][25053] 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-30 09:40:40,847 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-30 09:40:40,847 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-30 09:40:40,853 [salt.utils.extmods][INFO    ][25053] Syncing states for environment 'base'
2017-10-30 09:40:40,854 [salt.utils.extmods][INFO    ][25053] Loading cache from salt://_states, for base)
2017-10-30 09:40:40,854 [salt.fileclient  ][INFO    ][25053] Caching directory '_states/' for environment 'base'
2017-10-30 09:40:40,934 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-30 09:40:40,963 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-30 09:40:40,975 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-30 09:40:40,994 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-30 09:40:41,061 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-30 09:40:41,095 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-30 09:40:41,113 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-30 09:40:41,137 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-30 09:40:41,157 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-30 09:40:41,171 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-30 09:40:41,187 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-30 09:40:41,201 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-30 09:40:41,218 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-30 09:40:41,228 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-30 09:40:41,239 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-30 09:40:41,254 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-30 09:40:41,264 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-30 09:40:41,284 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-30 09:40:41,303 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-30 09:40:41,374 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-30 09:40:41,389 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-30 09:40:41,402 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-30 09:40:41,421 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-30 09:40:41,499 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-30 09:40:41,529 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-30 09:40:41,544 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-30 09:40:41,559 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-30 09:40:41,588 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-30 09:40:41,606 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-30 09:40:41,610 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-30 09:40:41,610 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-30 09:40:41,611 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-30 09:40:41,611 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-30 09:40:41,611 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-30 09:40:41,612 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-30 09:40:41,612 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-30 09:40:41,612 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-30 09:40:41,612 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-30 09:40:41,613 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-30 09:40:41,613 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-30 09:40:41,613 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-30 09:40:41,613 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-30 09:40:41,614 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-30 09:40:41,614 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-30 09:40:41,614 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-30 09:40:41,614 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-30 09:40:41,615 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-30 09:40:41,615 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-30 09:40:41,615 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-30 09:40:41,616 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-30 09:40:41,616 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-30 09:40:41,616 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-30 09:40:41,616 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-30 09:40:41,616 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-30 09:40:41,617 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-30 09:40:41,617 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-30 09:40:41,617 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-30 09:40:41,618 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-30 09:40:41,618 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-30 09:40:41,621 [salt.utils.extmods][INFO    ][25053] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-30 09:40:41,624 [salt.utils.extmods][INFO    ][25053] Syncing sdb for environment 'base'
2017-10-30 09:40:41,624 [salt.utils.extmods][INFO    ][25053] Loading cache from salt://_sdb, for base)
2017-10-30 09:40:41,624 [salt.fileclient  ][INFO    ][25053] Caching directory '_sdb/' for environment 'base'
2017-10-30 09:40:41,714 [salt.utils.extmods][INFO    ][25053] Syncing grains for environment 'base'
2017-10-30 09:40:41,715 [salt.utils.extmods][INFO    ][25053] Loading cache from salt://_grains, for base)
2017-10-30 09:40:41,715 [salt.fileclient  ][INFO    ][25053] Caching directory '_grains/' for environment 'base'
2017-10-30 09:40:41,776 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-30 09:40:41,800 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-30 09:40:41,859 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-30 09:40:41,872 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-30 09:40:41,894 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-30 09:40:41,909 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-30 09:40:41,922 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-30 09:40:41,936 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-30 09:40:41,961 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-30 09:40:41,981 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-30 09:40:41,996 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-30 09:40:42,038 [salt.fileclient  ][INFO    ][25053] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-30 09:40:42,042 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-30 09:40:42,043 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-30 09:40:42,043 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-30 09:40:42,043 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-30 09:40:42,044 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-30 09:40:42,044 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-30 09:40:42,044 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-30 09:40:42,044 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-30 09:40:42,044 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-30 09:40:42,045 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-30 09:40:42,045 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-30 09:40:42,045 [salt.utils.extmods][INFO    ][25053] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-30 09:40:42,047 [salt.utils.extmods][INFO    ][25053] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-30 09:40:42,050 [salt.utils.extmods][INFO    ][25053] Syncing renderers for environment 'base'
2017-10-30 09:40:42,050 [salt.utils.extmods][INFO    ][25053] Loading cache from salt://_renderers, for base)
2017-10-30 09:40:42,050 [salt.fileclient  ][INFO    ][25053] Caching directory '_renderers/' for environment 'base'
2017-10-30 09:40:42,110 [salt.utils.extmods][INFO    ][25053] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-30 09:40:42,113 [salt.utils.extmods][INFO    ][25053] Syncing returners for environment 'base'
2017-10-30 09:40:42,113 [salt.utils.extmods][INFO    ][25053] Loading cache from salt://_returners, for base)
2017-10-30 09:40:42,113 [salt.fileclient  ][INFO    ][25053] Caching directory '_returners/' for environment 'base'
2017-10-30 09:40:42,201 [salt.utils.extmods][INFO    ][25053] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-30 09:40:42,204 [salt.utils.extmods][INFO    ][25053] Syncing output for environment 'base'
2017-10-30 09:40:42,204 [salt.utils.extmods][INFO    ][25053] Loading cache from salt://_output, for base)
2017-10-30 09:40:42,204 [salt.fileclient  ][INFO    ][25053] Caching directory '_output/' for environment 'base'
2017-10-30 09:40:42,240 [salt.utils.extmods][INFO    ][25053] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-30 09:40:42,243 [salt.utils.extmods][INFO    ][25053] Syncing utils for environment 'base'
2017-10-30 09:40:42,243 [salt.utils.extmods][INFO    ][25053] Loading cache from salt://_utils, for base)
2017-10-30 09:40:42,243 [salt.fileclient  ][INFO    ][25053] Caching directory '_utils/' for environment 'base'
2017-10-30 09:40:42,294 [salt.utils.extmods][INFO    ][25053] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-30 09:40:42,296 [salt.utils.extmods][INFO    ][25053] Syncing log_handlers for environment 'base'
2017-10-30 09:40:42,297 [salt.utils.extmods][INFO    ][25053] Loading cache from salt://_log_handlers, for base)
2017-10-30 09:40:42,297 [salt.fileclient  ][INFO    ][25053] Caching directory '_log_handlers/' for environment 'base'
2017-10-30 09:40:42,351 [salt.utils.extmods][INFO    ][25053] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-30 09:40:42,353 [salt.utils.extmods][INFO    ][25053] Syncing proxy for environment 'base'
2017-10-30 09:40:42,354 [salt.utils.extmods][INFO    ][25053] Loading cache from salt://_proxy, for base)
2017-10-30 09:40:42,354 [salt.fileclient  ][INFO    ][25053] Caching directory '_proxy/' for environment 'base'
2017-10-30 09:40:42,389 [salt.utils.extmods][INFO    ][25053] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-30 09:40:42,393 [salt.utils.extmods][INFO    ][25053] Syncing engines for environment 'base'
2017-10-30 09:40:42,393 [salt.utils.extmods][INFO    ][25053] Loading cache from salt://_engines, for base)
2017-10-30 09:40:42,393 [salt.fileclient  ][INFO    ][25053] Caching directory '_engines/' for environment 'base'
2017-10-30 09:40:42,430 [salt.minion      ][INFO    ][25053] Returning information for job: 20171030094035138274
2017-10-30 09:45:34,494 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command test.ping with jid 20171030094534483409
2017-10-30 09:45:34,509 [salt.minion      ][INFO    ][25244] Starting a new job with PID 25244
2017-10-30 09:45:34,548 [salt.minion      ][INFO    ][25244] Returning information for job: 20171030094534483409
2017-10-30 09:47:31,209 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command state.sls with jid 20171030094731199011
2017-10-30 09:47:31,221 [salt.minion      ][INFO    ][25278] Starting a new job with PID 25278
2017-10-30 09:47:33,433 [salt.state       ][INFO    ][25278] Loading fresh modules for state activity
2017-10-30 09:47:33,465 [salt.fileclient  ][INFO    ][25278] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-30 09:47:33,486 [salt.fileclient  ][INFO    ][25278] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-30 09:47:33,514 [salt.fileclient  ][INFO    ][25278] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-30 09:47:33,849 [salt.state       ][INFO    ][25278] Running state [lsof] at time 09:47:33.848836
2017-10-30 09:47:33,849 [salt.state       ][INFO    ][25278] Executing state pkg.installed for lsof
2017-10-30 09:47:33,850 [salt.loaded.int.module.cmdmod][INFO    ][25278] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-30 09:47:34,127 [salt.state       ][INFO    ][25278] Package lsof is already installed
2017-10-30 09:47:34,127 [salt.state       ][INFO    ][25278] Completed state [lsof] at time 09:47:34.126912 duration_in_ms=278.076
2017-10-30 09:47:34,127 [salt.state       ][INFO    ][25278] Running state [keepalived] at time 09:47:34.127316
2017-10-30 09:47:34,128 [salt.state       ][INFO    ][25278] Executing state pkg.installed for keepalived
2017-10-30 09:47:34,145 [salt.loaded.int.module.cmdmod][INFO    ][25278] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-30 09:47:35,586 [salt.loaded.int.module.cmdmod][INFO    ][25278] 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-30 09:47:38,824 [salt.loaded.int.module.cmdmod][INFO    ][25278] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-30 09:47:38,851 [salt.state       ][INFO    ][25278] 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-30 09:47:38,861 [salt.state       ][INFO    ][25278] Loading fresh modules for state activity
2017-10-30 09:47:38,877 [salt.state       ][INFO    ][25278] Completed state [keepalived] at time 09:47:38.877049 duration_in_ms=4749.734
2017-10-30 09:47:38,879 [salt.state       ][INFO    ][25278] Running state [/etc/keepalived/keepalived.conf] at time 09:47:38.879376
2017-10-30 09:47:38,880 [salt.state       ][INFO    ][25278] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-30 09:47:38,901 [salt.fileclient  ][INFO    ][25278] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-30 09:47:38,937 [salt.fileclient  ][INFO    ][25278] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-30 09:47:38,945 [salt.state       ][INFO    ][25278] File changed:
New file
2017-10-30 09:47:38,945 [salt.state       ][INFO    ][25278] Completed state [/etc/keepalived/keepalived.conf] at time 09:47:38.945280 duration_in_ms=65.903
2017-10-30 09:47:39,008 [salt.state       ][INFO    ][25278] Running state [keepalived] at time 09:47:39.008386
2017-10-30 09:47:39,009 [salt.state       ][INFO    ][25278] Executing state service.running for keepalived
2017-10-30 09:47:39,010 [salt.loaded.int.module.cmdmod][INFO    ][25278] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-30 09:47:39,019 [salt.loaded.int.module.cmdmod][INFO    ][25278] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-30 09:47:39,026 [salt.loaded.int.module.cmdmod][INFO    ][25278] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-30 09:47:39,034 [salt.loaded.int.module.cmdmod][INFO    ][25278] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-30 09:47:39,041 [salt.loaded.int.module.cmdmod][INFO    ][25278] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-10-30 09:47:39,071 [salt.loaded.int.module.cmdmod][INFO    ][25278] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-30 09:47:39,079 [salt.loaded.int.module.cmdmod][INFO    ][25278] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-30 09:47:39,086 [salt.loaded.int.module.cmdmod][INFO    ][25278] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-30 09:47:39,092 [salt.state       ][INFO    ][25278] {'keepalived': True}
2017-10-30 09:47:39,092 [salt.state       ][INFO    ][25278] Completed state [keepalived] at time 09:47:39.091813 duration_in_ms=83.427
2017-10-30 09:47:39,093 [salt.minion      ][INFO    ][25278] Returning information for job: 20171030094731199011
2017-10-30 09:47:47,168 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command pillar.get with jid 20171030094747157035
2017-10-30 09:47:47,182 [salt.minion      ][INFO    ][26871] Starting a new job with PID 26871
2017-10-30 09:47:47,187 [salt.minion      ][INFO    ][26871] Returning information for job: 20171030094747157035
2017-10-30 09:52:40,743 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command state.sls with jid 20171030095240732225
2017-10-30 09:52:40,755 [salt.minion      ][INFO    ][26969] Starting a new job with PID 26969
2017-10-30 09:52:43,022 [salt.state       ][INFO    ][26969] Loading fresh modules for state activity
2017-10-30 09:52:43,048 [salt.fileclient  ][INFO    ][26969] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-30 09:52:43,074 [salt.fileclient  ][INFO    ][26969] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-30 09:52:43,379 [salt.state       ][INFO    ][26969] Running state [attr] at time 09:52:43.379398
2017-10-30 09:52:43,380 [salt.state       ][INFO    ][26969] Executing state pkg.installed for attr
2017-10-30 09:52:43,380 [salt.loaded.int.module.cmdmod][INFO    ][26969] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-30 09:52:43,664 [salt.loaded.int.module.cmdmod][INFO    ][26969] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-30 09:52:45,135 [salt.loaded.int.module.cmdmod][INFO    ][26969] 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-30 09:52:46,457 [salt.loaded.int.module.cmdmod][INFO    ][26969] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-30 09:52:46,484 [salt.state       ][INFO    ][26969] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-10-30 09:52:46,495 [salt.state       ][INFO    ][26969] Loading fresh modules for state activity
2017-10-30 09:52:46,512 [salt.state       ][INFO    ][26969] Completed state [attr] at time 09:52:46.512097 duration_in_ms=3132.7
2017-10-30 09:52:46,517 [salt.state       ][INFO    ][26969] Running state [glusterfs-server] at time 09:52:46.516857
2017-10-30 09:52:46,517 [salt.state       ][INFO    ][26969] Executing state pkg.installed for glusterfs-server
2017-10-30 09:52:46,741 [salt.loaded.int.module.cmdmod][INFO    ][26969] 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-30 09:52:50,852 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command saltutil.find_job with jid 20171030095250837529
2017-10-30 09:52:50,862 [salt.minion      ][INFO    ][30806] Starting a new job with PID 30806
2017-10-30 09:52:50,877 [salt.minion      ][INFO    ][30806] Returning information for job: 20171030095250837529
2017-10-30 09:52:53,267 [salt.loaded.int.module.cmdmod][INFO    ][26969] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-30 09:52:53,297 [salt.state       ][INFO    ][26969] 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-30 09:52:53,306 [salt.state       ][INFO    ][26969] Loading fresh modules for state activity
2017-10-30 09:52:53,323 [salt.state       ][INFO    ][26969] Completed state [glusterfs-server] at time 09:52:53.323406 duration_in_ms=6806.548
2017-10-30 09:52:53,328 [salt.state       ][INFO    ][26969] Running state [bc] at time 09:52:53.328054
2017-10-30 09:52:53,328 [salt.state       ][INFO    ][26969] Executing state pkg.installed for bc
2017-10-30 09:52:53,618 [salt.loaded.int.module.cmdmod][INFO    ][26969] 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-30 09:52:55,012 [salt.loaded.int.module.cmdmod][INFO    ][26969] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-30 09:52:55,043 [salt.state       ][INFO    ][26969] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-10-30 09:52:55,054 [salt.state       ][INFO    ][26969] Loading fresh modules for state activity
2017-10-30 09:52:55,072 [salt.state       ][INFO    ][26969] Completed state [bc] at time 09:52:55.071967 duration_in_ms=1743.912
2017-10-30 09:52:55,141 [salt.state       ][INFO    ][26969] Running state [glusterfs-server] at time 09:52:55.140801
2017-10-30 09:52:55,141 [salt.state       ][INFO    ][26969] Executing state service.running for glusterfs-server
2017-10-30 09:52:55,145 [salt.loaded.int.module.cmdmod][INFO    ][26969] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-30 09:52:55,155 [salt.loaded.int.module.cmdmod][INFO    ][26969] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-30 09:52:55,164 [salt.loaded.int.module.cmdmod][INFO    ][26969] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-30 09:52:55,174 [salt.state       ][INFO    ][26969] The service glusterfs-server is already running
2017-10-30 09:52:55,174 [salt.state       ][INFO    ][26969] Completed state [glusterfs-server] at time 09:52:55.173824 duration_in_ms=33.025
2017-10-30 09:52:55,175 [salt.state       ][INFO    ][26969] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:52:55.175293
2017-10-30 09:52:55,176 [salt.state       ][INFO    ][26969] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-30 09:52:55,180 [salt.state       ][INFO    ][26969] File changed:
New file
2017-10-30 09:52:55,180 [salt.state       ][INFO    ][26969] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:52:55.180230 duration_in_ms=4.937
2017-10-30 09:52:55,180 [salt.state       ][INFO    ][26969] Running state [/srv/glusterfs/glance] at time 09:52:55.180427
2017-10-30 09:52:55,181 [salt.state       ][INFO    ][26969] Executing state file.directory for /srv/glusterfs/glance
2017-10-30 09:52:55,181 [salt.state       ][INFO    ][26969] {'/srv/glusterfs/glance': 'New Dir'}
2017-10-30 09:52:55,181 [salt.state       ][INFO    ][26969] Completed state [/srv/glusterfs/glance] at time 09:52:55.181457 duration_in_ms=1.031
2017-10-30 09:52:55,182 [salt.state       ][INFO    ][26969] Running state [/srv/glusterfs/keystone-keys] at time 09:52:55.181635
2017-10-30 09:52:55,182 [salt.state       ][INFO    ][26969] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-30 09:52:55,182 [salt.state       ][INFO    ][26969] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-10-30 09:52:55,182 [salt.state       ][INFO    ][26969] Completed state [/srv/glusterfs/keystone-keys] at time 09:52:55.182457 duration_in_ms=0.822
2017-10-30 09:52:55,183 [salt.state       ][INFO    ][26969] Running state [/srv/glusterfs/nova_instances] at time 09:52:55.182654
2017-10-30 09:52:55,183 [salt.state       ][INFO    ][26969] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-30 09:52:55,183 [salt.state       ][INFO    ][26969] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-10-30 09:52:55,183 [salt.state       ][INFO    ][26969] Completed state [/srv/glusterfs/nova_instances] at time 09:52:55.183450 duration_in_ms=0.796
2017-10-30 09:52:55,184 [salt.state       ][INFO    ][26969] Running state [/srv/glusterfs/keystone-credential-keys] at time 09:52:55.183637
2017-10-30 09:52:55,184 [salt.state       ][INFO    ][26969] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-30 09:52:55,184 [salt.state       ][INFO    ][26969] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-10-30 09:52:55,184 [salt.state       ][INFO    ][26969] Completed state [/srv/glusterfs/keystone-credential-keys] at time 09:52:55.184443 duration_in_ms=0.806
2017-10-30 09:52:55,185 [salt.minion      ][INFO    ][26969] Returning information for job: 20171030095240732225
2017-10-30 09:53:03,870 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command test.ping with jid 20171030095303857499
2017-10-30 09:53:03,882 [salt.minion      ][INFO    ][31702] Starting a new job with PID 31702
2017-10-30 09:53:03,920 [salt.minion      ][INFO    ][31702] Returning information for job: 20171030095303857499
2017-10-30 09:53:36,472 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command state.sls with jid 20171030095336459373
2017-10-30 09:53:36,484 [salt.minion      ][INFO    ][31926] Starting a new job with PID 31926
2017-10-30 09:53:37,051 [salt.state       ][INFO    ][31926] Loading fresh modules for state activity
2017-10-30 09:53:37,082 [salt.fileclient  ][INFO    ][31926] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-30 09:53:37,119 [salt.fileclient  ][INFO    ][31926] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-30 09:53:37,200 [salt.fileclient  ][INFO    ][31926] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-30 09:53:37,223 [salt.fileclient  ][INFO    ][31926] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-30 09:53:37,522 [salt.state       ][INFO    ][31926] Running state [attr] at time 09:53:37.522179
2017-10-30 09:53:37,522 [salt.state       ][INFO    ][31926] Executing state pkg.installed for attr
2017-10-30 09:53:37,523 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-30 09:53:37,771 [salt.state       ][INFO    ][31926] Package attr is already installed
2017-10-30 09:53:37,771 [salt.state       ][INFO    ][31926] Completed state [attr] at time 09:53:37.771072 duration_in_ms=248.894
2017-10-30 09:53:37,771 [salt.state       ][INFO    ][31926] Running state [glusterfs-server] at time 09:53:37.771339
2017-10-30 09:53:37,772 [salt.state       ][INFO    ][31926] Executing state pkg.installed for glusterfs-server
2017-10-30 09:53:37,775 [salt.state       ][INFO    ][31926] Package glusterfs-server is already installed
2017-10-30 09:53:37,775 [salt.state       ][INFO    ][31926] Completed state [glusterfs-server] at time 09:53:37.775350 duration_in_ms=4.01
2017-10-30 09:53:37,776 [salt.state       ][INFO    ][31926] Running state [bc] at time 09:53:37.775545
2017-10-30 09:53:37,776 [salt.state       ][INFO    ][31926] Executing state pkg.installed for bc
2017-10-30 09:53:37,779 [salt.state       ][INFO    ][31926] Package bc is already installed
2017-10-30 09:53:37,779 [salt.state       ][INFO    ][31926] Completed state [bc] at time 09:53:37.779442 duration_in_ms=3.897
2017-10-30 09:53:37,780 [salt.state       ][INFO    ][31926] Running state [glusterfs-server] at time 09:53:37.780385
2017-10-30 09:53:37,781 [salt.state       ][INFO    ][31926] Executing state service.running for glusterfs-server
2017-10-30 09:53:37,781 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-30 09:53:37,790 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-10-30 09:53:37,839 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-30 09:53:37,853 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-30 09:53:37,860 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-30 09:53:37,867 [salt.state       ][INFO    ][31926] The service glusterfs-server is already running
2017-10-30 09:53:37,867 [salt.state       ][INFO    ][31926] Completed state [glusterfs-server] at time 09:53:37.867355 duration_in_ms=86.97
2017-10-30 09:53:37,869 [salt.state       ][INFO    ][31926] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:53:37.868760
2017-10-30 09:53:37,869 [salt.state       ][INFO    ][31926] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-30 09:53:37,871 [salt.state       ][INFO    ][31926] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-30 09:53:37,871 [salt.state       ][INFO    ][31926] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:53:37.871005 duration_in_ms=2.245
2017-10-30 09:53:37,871 [salt.state       ][INFO    ][31926] Running state [/srv/glusterfs/glance] at time 09:53:37.871189
2017-10-30 09:53:37,871 [salt.state       ][INFO    ][31926] Executing state file.directory for /srv/glusterfs/glance
2017-10-30 09:53:37,872 [salt.state       ][INFO    ][31926] Directory /srv/glusterfs/glance is in the correct state
2017-10-30 09:53:37,872 [salt.state       ][INFO    ][31926] Completed state [/srv/glusterfs/glance] at time 09:53:37.871907 duration_in_ms=0.717
2017-10-30 09:53:37,872 [salt.state       ][INFO    ][31926] Running state [/srv/glusterfs/keystone-keys] at time 09:53:37.872083
2017-10-30 09:53:37,872 [salt.state       ][INFO    ][31926] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-30 09:53:37,873 [salt.state       ][INFO    ][31926] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-30 09:53:37,873 [salt.state       ][INFO    ][31926] Completed state [/srv/glusterfs/keystone-keys] at time 09:53:37.872746 duration_in_ms=0.662
2017-10-30 09:53:37,873 [salt.state       ][INFO    ][31926] Running state [/srv/glusterfs/nova_instances] at time 09:53:37.872917
2017-10-30 09:53:37,873 [salt.state       ][INFO    ][31926] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-30 09:53:37,873 [salt.state       ][INFO    ][31926] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-30 09:53:37,874 [salt.state       ][INFO    ][31926] Completed state [/srv/glusterfs/nova_instances] at time 09:53:37.873571 duration_in_ms=0.655
2017-10-30 09:53:37,874 [salt.state       ][INFO    ][31926] Running state [/srv/glusterfs/keystone-credential-keys] at time 09:53:37.873748
2017-10-30 09:53:37,874 [salt.state       ][INFO    ][31926] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-30 09:53:37,874 [salt.state       ][INFO    ][31926] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-30 09:53:37,874 [salt.state       ][INFO    ][31926] Completed state [/srv/glusterfs/keystone-credential-keys] at time 09:53:37.874400 duration_in_ms=0.652
2017-10-30 09:53:37,936 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command ['git', '--version'] in directory '/root'
2017-10-30 09:53:38,010 [salt.state       ][INFO    ][31926] Running state [sleep 5] at time 09:53:38.009644
2017-10-30 09:53:38,010 [salt.state       ][INFO    ][31926] Executing state cmd.wait for sleep 5
2017-10-30 09:53:38,010 [salt.state       ][INFO    ][31926] No changes made for sleep 5
2017-10-30 09:53:38,010 [salt.state       ][INFO    ][31926] Completed state [sleep 5] at time 09:53:38.010272 duration_in_ms=0.629
2017-10-30 09:53:38,011 [salt.state       ][INFO    ][31926] Running state [192.168.10.143] at time 09:53:38.010797
2017-10-30 09:53:38,011 [salt.state       ][INFO    ][31926] Executing state glusterfs.peered for 192.168.10.143
2017-10-30 09:53:38,011 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:38,019 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:38,071 [salt.state       ][INFO    ][31926] Host 192.168.10.143 already peered
2017-10-30 09:53:38,071 [salt.state       ][INFO    ][31926] Completed state [192.168.10.143] at time 09:53:38.071249 duration_in_ms=60.451
2017-10-30 09:53:38,074 [salt.state       ][INFO    ][31926] Running state [192.168.10.142] at time 09:53:38.074001
2017-10-30 09:53:38,074 [salt.state       ][INFO    ][31926] Executing state glusterfs.peered for 192.168.10.142
2017-10-30 09:53:38,075 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:38,083 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:38,134 [salt.state       ][INFO    ][31926] Host 192.168.10.142 already peered
2017-10-30 09:53:38,135 [salt.state       ][INFO    ][31926] Completed state [192.168.10.142] at time 09:53:38.134607 duration_in_ms=60.605
2017-10-30 09:53:38,138 [salt.state       ][INFO    ][31926] Running state [192.168.10.141] at time 09:53:38.137537
2017-10-30 09:53:38,138 [salt.state       ][INFO    ][31926] Executing state glusterfs.peered for 192.168.10.141
2017-10-30 09:53:38,138 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:38,146 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:38,195 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:38,201 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:38,250 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:38,258 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:38,309 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:38,316 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:38,367 [salt.state       ][INFO    ][31926] Peering with localhost is not needed
2017-10-30 09:53:38,367 [salt.state       ][INFO    ][31926] Completed state [192.168.10.141] at time 09:53:38.366951 duration_in_ms=229.414
2017-10-30 09:53:38,368 [salt.state       ][INFO    ][31926] Running state [glance] at time 09:53:38.367989
2017-10-30 09:53:38,368 [salt.state       ][INFO    ][31926] Executing state glusterfs.created for glance
2017-10-30 09:53:38,369 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:38,376 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:38,427 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:38,434 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:38,491 [salt.state       ][INFO    ][31926] Volume glance already exists and is started.
2017-10-30 09:53:38,491 [salt.state       ][INFO    ][31926] Completed state [glance] at time 09:53:38.491141 duration_in_ms=123.151
2017-10-30 09:53:38,495 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 09:53:38.494599
2017-10-30 09:53:38,495 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-30 09:53:38,495 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-30 09:53:38,546 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:38,547 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 09:53:38.546536 duration_in_ms=51.937
2017-10-30 09:53:38,547 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 09:53:38.547168
2017-10-30 09:53:38,547 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-30 09:53:38,548 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-30 09:53:38,600 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:38,600 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 09:53:38.599899 duration_in_ms=52.73
2017-10-30 09:53:38,600 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 09:53:38.600427
2017-10-30 09:53:38,601 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-30 09:53:38,601 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-30 09:53:38,653 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:38,653 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 09:53:38.652978 duration_in_ms=52.55
2017-10-30 09:53:38,654 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 09:53:38.653494
2017-10-30 09:53:38,654 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-30 09:53:38,655 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-30 09:53:38,705 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:38,705 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 09:53:38.705217 duration_in_ms=51.721
2017-10-30 09:53:38,706 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 09:53:38.705914
2017-10-30 09:53:38,706 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-30 09:53:38,707 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-30 09:53:38,759 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:38,760 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 09:53:38.759661 duration_in_ms=53.747
2017-10-30 09:53:38,761 [salt.state       ][INFO    ][31926] Running state [glance] at time 09:53:38.760851
2017-10-30 09:53:38,761 [salt.state       ][INFO    ][31926] Executing state glusterfs.started for glance
2017-10-30 09:53:38,762 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:38,770 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:38,822 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:38,828 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:38,885 [salt.state       ][INFO    ][31926] Volume glance is already started
2017-10-30 09:53:38,885 [salt.state       ][INFO    ][31926] Completed state [glance] at time 09:53:38.884945 duration_in_ms=124.093
2017-10-30 09:53:38,886 [salt.state       ][INFO    ][31926] Running state [keystone-keys] at time 09:53:38.885941
2017-10-30 09:53:38,886 [salt.state       ][INFO    ][31926] Executing state glusterfs.created for keystone-keys
2017-10-30 09:53:38,887 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:38,894 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:38,945 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:38,952 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:39,008 [salt.state       ][INFO    ][31926] Volume keystone-keys already exists and is started.
2017-10-30 09:53:39,008 [salt.state       ][INFO    ][31926] Completed state [keystone-keys] at time 09:53:39.007869 duration_in_ms=121.928
2017-10-30 09:53:39,012 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 09:53:39.011483
2017-10-30 09:53:39,012 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-30 09:53:39,012 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-30 09:53:39,064 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:39,064 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 09:53:39.063956 duration_in_ms=52.473
2017-10-30 09:53:39,065 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:53:39.064501
2017-10-30 09:53:39,065 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-30 09:53:39,065 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-30 09:53:39,118 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:39,118 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:53:39.118204 duration_in_ms=53.701
2017-10-30 09:53:39,119 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:53:39.118853
2017-10-30 09:53:39,119 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-30 09:53:39,120 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-30 09:53:39,171 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:39,171 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:53:39.171049 duration_in_ms=52.195
2017-10-30 09:53:39,172 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 09:53:39.171615
2017-10-30 09:53:39,172 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-30 09:53:39,172 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-30 09:53:39,223 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:39,223 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 09:53:39.222915 duration_in_ms=51.3
2017-10-30 09:53:39,224 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 09:53:39.223490
2017-10-30 09:53:39,224 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-30 09:53:39,224 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-30 09:53:39,275 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:39,276 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 09:53:39.275584 duration_in_ms=52.094
2017-10-30 09:53:39,277 [salt.state       ][INFO    ][31926] Running state [keystone-keys] at time 09:53:39.276854
2017-10-30 09:53:39,277 [salt.state       ][INFO    ][31926] Executing state glusterfs.started for keystone-keys
2017-10-30 09:53:39,278 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:39,285 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:39,336 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:39,342 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:39,398 [salt.state       ][INFO    ][31926] Volume keystone-keys is already started
2017-10-30 09:53:39,398 [salt.state       ][INFO    ][31926] Completed state [keystone-keys] at time 09:53:39.398441 duration_in_ms=121.587
2017-10-30 09:53:39,400 [salt.state       ][INFO    ][31926] Running state [nova_instances] at time 09:53:39.399520
2017-10-30 09:53:39,400 [salt.state       ][INFO    ][31926] Executing state glusterfs.created for nova_instances
2017-10-30 09:53:39,400 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:39,406 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:39,458 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:39,465 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:39,520 [salt.state       ][INFO    ][31926] Volume nova_instances already exists and is started.
2017-10-30 09:53:39,521 [salt.state       ][INFO    ][31926] Completed state [nova_instances] at time 09:53:39.520455 duration_in_ms=120.933
2017-10-30 09:53:39,524 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 09:53:39.524298
2017-10-30 09:53:39,525 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-30 09:53:39,525 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-30 09:53:39,576 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:39,576 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 09:53:39.576140 duration_in_ms=51.842
2017-10-30 09:53:39,577 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 09:53:39.576786
2017-10-30 09:53:39,577 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-30 09:53:39,578 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-30 09:53:39,629 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:39,629 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 09:53:39.629058 duration_in_ms=52.271
2017-10-30 09:53:39,630 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 09:53:39.629558
2017-10-30 09:53:39,630 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-30 09:53:39,630 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-30 09:53:39,682 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:39,682 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 09:53:39.682258 duration_in_ms=52.7
2017-10-30 09:53:39,686 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 09:53:39.685083
2017-10-30 09:53:39,686 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-30 09:53:39,688 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-30 09:53:39,742 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:39,742 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 09:53:39.741818 duration_in_ms=56.737
2017-10-30 09:53:39,742 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 09:53:39.742445
2017-10-30 09:53:39,743 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-30 09:53:39,743 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-30 09:53:39,794 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:39,794 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 09:53:39.794364 duration_in_ms=51.918
2017-10-30 09:53:39,796 [salt.state       ][INFO    ][31926] Running state [nova_instances] at time 09:53:39.795660
2017-10-30 09:53:39,796 [salt.state       ][INFO    ][31926] Executing state glusterfs.started for nova_instances
2017-10-30 09:53:39,796 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:39,804 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:39,854 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:39,862 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:39,918 [salt.state       ][INFO    ][31926] Volume nova_instances is already started
2017-10-30 09:53:39,918 [salt.state       ][INFO    ][31926] Completed state [nova_instances] at time 09:53:39.917849 duration_in_ms=122.188
2017-10-30 09:53:39,919 [salt.state       ][INFO    ][31926] Running state [keystone-credential-keys] at time 09:53:39.919010
2017-10-30 09:53:39,919 [salt.state       ][INFO    ][31926] Executing state glusterfs.created for keystone-credential-keys
2017-10-30 09:53:39,920 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:39,927 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:39,978 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:39,985 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:40,041 [salt.state       ][INFO    ][31926] Volume keystone-credential-keys already exists and is started.
2017-10-30 09:53:40,041 [salt.state       ][INFO    ][31926] Completed state [keystone-credential-keys] at time 09:53:40.040854 duration_in_ms=121.843
2017-10-30 09:53:40,045 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 09:53:40.045344
2017-10-30 09:53:40,046 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-30 09:53:40,046 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-30 09:53:40,099 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:40,099 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 09:53:40.099182 duration_in_ms=53.838
2017-10-30 09:53:40,100 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:53:40.099723
2017-10-30 09:53:40,100 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-30 09:53:40,100 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-30 09:53:40,151 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:40,151 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:53:40.150970 duration_in_ms=51.246
2017-10-30 09:53:40,151 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 09:53:40.151434
2017-10-30 09:53:40,152 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-30 09:53:40,152 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-30 09:53:40,204 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:40,204 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 09:53:40.204153 duration_in_ms=52.717
2017-10-30 09:53:40,205 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:53:40.204812
2017-10-30 09:53:40,205 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-30 09:53:40,206 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-30 09:53:40,258 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:40,258 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:53:40.257860 duration_in_ms=53.048
2017-10-30 09:53:40,258 [salt.state       ][INFO    ][31926] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 09:53:40.258402
2017-10-30 09:53:40,259 [salt.state       ][INFO    ][31926] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-30 09:53:40,259 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-30 09:53:40,311 [salt.state       ][INFO    ][31926] unless execution succeeded
2017-10-30 09:53:40,312 [salt.state       ][INFO    ][31926] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 09:53:40.311532 duration_in_ms=53.13
2017-10-30 09:53:40,313 [salt.state       ][INFO    ][31926] Running state [keystone-credential-keys] at time 09:53:40.312785
2017-10-30 09:53:40,313 [salt.state       ][INFO    ][31926] Executing state glusterfs.started for keystone-credential-keys
2017-10-30 09:53:40,313 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:40,322 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:40,374 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --version' in directory '/root'
2017-10-30 09:53:40,382 [salt.loaded.int.module.cmdmod][INFO    ][31926] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 09:53:40,437 [salt.state       ][INFO    ][31926] Volume keystone-credential-keys is already started
2017-10-30 09:53:40,437 [salt.state       ][INFO    ][31926] Completed state [keystone-credential-keys] at time 09:53:40.437331 duration_in_ms=124.546
2017-10-30 09:53:40,439 [salt.minion      ][INFO    ][31926] Returning information for job: 20171030095336459373
2017-10-30 09:53:41,477 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command test.ping with jid 20171030095341465826
2017-10-30 09:53:41,487 [salt.minion      ][INFO    ][32325] Starting a new job with PID 32325
2017-10-30 09:53:41,521 [salt.minion      ][INFO    ][32325] Returning information for job: 20171030095341465826
2017-10-30 09:53:42,285 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command cmd.run with jid 20171030095342273686
2017-10-30 09:53:42,296 [salt.minion      ][INFO    ][32330] Starting a new job with PID 32330
2017-10-30 09:53:42,300 [salt.loaded.int.module.cmdmod][INFO    ][32330] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-30 09:53:42,415 [salt.minion      ][INFO    ][32330] Returning information for job: 20171030095342273686
2017-10-30 10:34:51,307 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command test.ping with jid 20171030103451295865
2017-10-30 10:34:51,328 [salt.minion      ][INFO    ][33044] Starting a new job with PID 33044
2017-10-30 10:34:51,365 [salt.minion      ][INFO    ][33044] Returning information for job: 20171030103451295865
2017-10-30 10:35:26,998 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command state.sls with jid 20171030103526985063
2017-10-30 10:35:27,010 [salt.minion      ][INFO    ][33053] Starting a new job with PID 33053
2017-10-30 10:35:27,589 [salt.state       ][INFO    ][33053] Loading fresh modules for state activity
2017-10-30 10:35:27,621 [salt.fileclient  ][INFO    ][33053] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-30 10:35:27,641 [salt.fileclient  ][INFO    ][33053] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-30 10:35:27,671 [salt.fileclient  ][INFO    ][33053] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-30 10:35:27,969 [salt.state       ][INFO    ][33053] Running state [lsof] at time 10:35:27.969396
2017-10-30 10:35:27,970 [salt.state       ][INFO    ][33053] Executing state pkg.installed for lsof
2017-10-30 10:35:27,970 [salt.loaded.int.module.cmdmod][INFO    ][33053] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-30 10:35:28,236 [salt.state       ][INFO    ][33053] Package lsof is already installed
2017-10-30 10:35:28,237 [salt.state       ][INFO    ][33053] Completed state [lsof] at time 10:35:28.236448 duration_in_ms=267.052
2017-10-30 10:35:28,237 [salt.state       ][INFO    ][33053] Running state [keepalived] at time 10:35:28.236695
2017-10-30 10:35:28,237 [salt.state       ][INFO    ][33053] Executing state pkg.installed for keepalived
2017-10-30 10:35:28,241 [salt.state       ][INFO    ][33053] Package keepalived is already installed
2017-10-30 10:35:28,241 [salt.state       ][INFO    ][33053] Completed state [keepalived] at time 10:35:28.240840 duration_in_ms=4.145
2017-10-30 10:35:28,242 [salt.state       ][INFO    ][33053] Running state [/etc/keepalived/keepalived.conf] at time 10:35:28.242378
2017-10-30 10:35:28,243 [salt.state       ][INFO    ][33053] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-30 10:35:28,271 [salt.fileclient  ][INFO    ][33053] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-30 10:35:28,311 [salt.fileclient  ][INFO    ][33053] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-30 10:35:28,316 [salt.state       ][INFO    ][33053] File /etc/keepalived/keepalived.conf is in the correct state
2017-10-30 10:35:28,317 [salt.state       ][INFO    ][33053] Completed state [/etc/keepalived/keepalived.conf] at time 10:35:28.316591 duration_in_ms=74.213
2017-10-30 10:35:28,317 [salt.state       ][INFO    ][33053] Running state [keepalived] at time 10:35:28.317228
2017-10-30 10:35:28,317 [salt.state       ][INFO    ][33053] Executing state service.running for keepalived
2017-10-30 10:35:28,318 [salt.loaded.int.module.cmdmod][INFO    ][33053] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-30 10:35:28,331 [salt.loaded.int.module.cmdmod][INFO    ][33053] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-30 10:35:28,336 [salt.loaded.int.module.cmdmod][INFO    ][33053] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-30 10:35:28,342 [salt.state       ][INFO    ][33053] The service keepalived is already running
2017-10-30 10:35:28,342 [salt.state       ][INFO    ][33053] Completed state [keepalived] at time 10:35:28.342187 duration_in_ms=24.958
2017-10-30 10:35:28,343 [salt.minion      ][INFO    ][33053] Returning information for job: 20171030103526985063
2017-10-30 10:35:29,263 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command pillar.get with jid 20171030103529250637
2017-10-30 10:35:29,280 [salt.minion      ][INFO    ][33077] Starting a new job with PID 33077
2017-10-30 10:35:29,284 [salt.minion      ][INFO    ][33077] Returning information for job: 20171030103529250637
2017-10-30 10:36:19,838 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command state.sls with jid 20171030103619826166
2017-10-30 10:36:19,850 [salt.minion      ][INFO    ][33086] Starting a new job with PID 33086
2017-10-30 10:36:22,429 [salt.state       ][INFO    ][33086] Loading fresh modules for state activity
2017-10-30 10:36:22,459 [salt.fileclient  ][INFO    ][33086] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-30 10:36:22,482 [salt.fileclient  ][INFO    ][33086] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-30 10:36:22,781 [salt.state       ][INFO    ][33086] Running state [attr] at time 10:36:22.780749
2017-10-30 10:36:22,781 [salt.state       ][INFO    ][33086] Executing state pkg.installed for attr
2017-10-30 10:36:22,782 [salt.loaded.int.module.cmdmod][INFO    ][33086] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-30 10:36:23,039 [salt.state       ][INFO    ][33086] Package attr is already installed
2017-10-30 10:36:23,040 [salt.state       ][INFO    ][33086] Completed state [attr] at time 10:36:23.039472 duration_in_ms=258.723
2017-10-30 10:36:23,040 [salt.state       ][INFO    ][33086] Running state [glusterfs-server] at time 10:36:23.039747
2017-10-30 10:36:23,040 [salt.state       ][INFO    ][33086] Executing state pkg.installed for glusterfs-server
2017-10-30 10:36:23,044 [salt.state       ][INFO    ][33086] Package glusterfs-server is already installed
2017-10-30 10:36:23,044 [salt.state       ][INFO    ][33086] Completed state [glusterfs-server] at time 10:36:23.043800 duration_in_ms=4.053
2017-10-30 10:36:23,044 [salt.state       ][INFO    ][33086] Running state [bc] at time 10:36:23.043994
2017-10-30 10:36:23,044 [salt.state       ][INFO    ][33086] Executing state pkg.installed for bc
2017-10-30 10:36:23,048 [salt.state       ][INFO    ][33086] Package bc is already installed
2017-10-30 10:36:23,048 [salt.state       ][INFO    ][33086] Completed state [bc] at time 10:36:23.047919 duration_in_ms=3.925
2017-10-30 10:36:23,049 [salt.state       ][INFO    ][33086] Running state [glusterfs-server] at time 10:36:23.048709
2017-10-30 10:36:23,049 [salt.state       ][INFO    ][33086] Executing state service.running for glusterfs-server
2017-10-30 10:36:23,049 [salt.loaded.int.module.cmdmod][INFO    ][33086] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-30 10:36:23,066 [salt.loaded.int.module.cmdmod][INFO    ][33086] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-30 10:36:23,073 [salt.loaded.int.module.cmdmod][INFO    ][33086] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-30 10:36:23,083 [salt.state       ][INFO    ][33086] The service glusterfs-server is already running
2017-10-30 10:36:23,083 [salt.state       ][INFO    ][33086] Completed state [glusterfs-server] at time 10:36:23.083344 duration_in_ms=34.635
2017-10-30 10:36:23,085 [salt.state       ][INFO    ][33086] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:36:23.084905
2017-10-30 10:36:23,085 [salt.state       ][INFO    ][33086] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-30 10:36:23,087 [salt.state       ][INFO    ][33086] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-30 10:36:23,087 [salt.state       ][INFO    ][33086] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:36:23.087391 duration_in_ms=2.487
2017-10-30 10:36:23,088 [salt.state       ][INFO    ][33086] Running state [/srv/glusterfs/glance] at time 10:36:23.087578
2017-10-30 10:36:23,088 [salt.state       ][INFO    ][33086] Executing state file.directory for /srv/glusterfs/glance
2017-10-30 10:36:23,088 [salt.state       ][INFO    ][33086] Directory /srv/glusterfs/glance is in the correct state
2017-10-30 10:36:23,088 [salt.state       ][INFO    ][33086] Completed state [/srv/glusterfs/glance] at time 10:36:23.088285 duration_in_ms=0.706
2017-10-30 10:36:23,088 [salt.state       ][INFO    ][33086] Running state [/srv/glusterfs/keystone-keys] at time 10:36:23.088465
2017-10-30 10:36:23,089 [salt.state       ][INFO    ][33086] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-30 10:36:23,089 [salt.state       ][INFO    ][33086] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-30 10:36:23,089 [salt.state       ][INFO    ][33086] Completed state [/srv/glusterfs/keystone-keys] at time 10:36:23.089170 duration_in_ms=0.704
2017-10-30 10:36:23,089 [salt.state       ][INFO    ][33086] Running state [/srv/glusterfs/nova_instances] at time 10:36:23.089332
2017-10-30 10:36:23,089 [salt.state       ][INFO    ][33086] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-30 10:36:23,090 [salt.state       ][INFO    ][33086] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-30 10:36:23,090 [salt.state       ][INFO    ][33086] Completed state [/srv/glusterfs/nova_instances] at time 10:36:23.089959 duration_in_ms=0.626
2017-10-30 10:36:23,090 [salt.state       ][INFO    ][33086] Running state [/srv/glusterfs/keystone-credential-keys] at time 10:36:23.090141
2017-10-30 10:36:23,090 [salt.state       ][INFO    ][33086] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-30 10:36:23,091 [salt.state       ][INFO    ][33086] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-30 10:36:23,091 [salt.state       ][INFO    ][33086] Completed state [/srv/glusterfs/keystone-credential-keys] at time 10:36:23.090901 duration_in_ms=0.759
2017-10-30 10:36:23,092 [salt.minion      ][INFO    ][33086] Returning information for job: 20171030103619826166
2017-10-30 10:36:24,457 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command test.ping with jid 20171030103624444443
2017-10-30 10:36:24,469 [salt.minion      ][INFO    ][33109] Starting a new job with PID 33109
2017-10-30 10:36:24,506 [salt.minion      ][INFO    ][33109] Returning information for job: 20171030103624444443
2017-10-30 10:36:35,511 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command state.sls with jid 20171030103635493454
2017-10-30 10:36:35,524 [salt.minion      ][INFO    ][33115] Starting a new job with PID 33115
2017-10-30 10:36:36,108 [salt.state       ][INFO    ][33115] Loading fresh modules for state activity
2017-10-30 10:36:36,135 [salt.fileclient  ][INFO    ][33115] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-30 10:36:36,171 [salt.fileclient  ][INFO    ][33115] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-30 10:36:36,251 [salt.fileclient  ][INFO    ][33115] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-30 10:36:36,271 [salt.fileclient  ][INFO    ][33115] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-30 10:36:36,570 [salt.state       ][INFO    ][33115] Running state [attr] at time 10:36:36.569504
2017-10-30 10:36:36,570 [salt.state       ][INFO    ][33115] Executing state pkg.installed for attr
2017-10-30 10:36:36,570 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-30 10:36:36,866 [salt.state       ][INFO    ][33115] Package attr is already installed
2017-10-30 10:36:36,867 [salt.state       ][INFO    ][33115] Completed state [attr] at time 10:36:36.866766 duration_in_ms=297.262
2017-10-30 10:36:36,867 [salt.state       ][INFO    ][33115] Running state [glusterfs-server] at time 10:36:36.867011
2017-10-30 10:36:36,867 [salt.state       ][INFO    ][33115] Executing state pkg.installed for glusterfs-server
2017-10-30 10:36:36,871 [salt.state       ][INFO    ][33115] Package glusterfs-server is already installed
2017-10-30 10:36:36,871 [salt.state       ][INFO    ][33115] Completed state [glusterfs-server] at time 10:36:36.871142 duration_in_ms=4.131
2017-10-30 10:36:36,871 [salt.state       ][INFO    ][33115] Running state [bc] at time 10:36:36.871335
2017-10-30 10:36:36,872 [salt.state       ][INFO    ][33115] Executing state pkg.installed for bc
2017-10-30 10:36:36,875 [salt.state       ][INFO    ][33115] Package bc is already installed
2017-10-30 10:36:36,875 [salt.state       ][INFO    ][33115] Completed state [bc] at time 10:36:36.875393 duration_in_ms=4.058
2017-10-30 10:36:36,876 [salt.state       ][INFO    ][33115] Running state [glusterfs-server] at time 10:36:36.876420
2017-10-30 10:36:36,877 [salt.state       ][INFO    ][33115] Executing state service.running for glusterfs-server
2017-10-30 10:36:36,877 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-30 10:36:36,892 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-30 10:36:36,899 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-30 10:36:36,908 [salt.state       ][INFO    ][33115] The service glusterfs-server is already running
2017-10-30 10:36:36,909 [salt.state       ][INFO    ][33115] Completed state [glusterfs-server] at time 10:36:36.908633 duration_in_ms=32.213
2017-10-30 10:36:36,910 [salt.state       ][INFO    ][33115] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:36:36.910309
2017-10-30 10:36:36,911 [salt.state       ][INFO    ][33115] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-30 10:36:36,913 [salt.state       ][INFO    ][33115] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-30 10:36:36,913 [salt.state       ][INFO    ][33115] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:36:36.912930 duration_in_ms=2.621
2017-10-30 10:36:36,913 [salt.state       ][INFO    ][33115] Running state [/srv/glusterfs/glance] at time 10:36:36.913159
2017-10-30 10:36:36,913 [salt.state       ][INFO    ][33115] Executing state file.directory for /srv/glusterfs/glance
2017-10-30 10:36:36,914 [salt.state       ][INFO    ][33115] Directory /srv/glusterfs/glance is in the correct state
2017-10-30 10:36:36,914 [salt.state       ][INFO    ][33115] Completed state [/srv/glusterfs/glance] at time 10:36:36.913973 duration_in_ms=0.813
2017-10-30 10:36:36,914 [salt.state       ][INFO    ][33115] Running state [/srv/glusterfs/keystone-keys] at time 10:36:36.914156
2017-10-30 10:36:36,914 [salt.state       ][INFO    ][33115] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-30 10:36:36,915 [salt.state       ][INFO    ][33115] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-30 10:36:36,915 [salt.state       ][INFO    ][33115] Completed state [/srv/glusterfs/keystone-keys] at time 10:36:36.914935 duration_in_ms=0.779
2017-10-30 10:36:36,915 [salt.state       ][INFO    ][33115] Running state [/srv/glusterfs/nova_instances] at time 10:36:36.915119
2017-10-30 10:36:36,915 [salt.state       ][INFO    ][33115] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-30 10:36:36,916 [salt.state       ][INFO    ][33115] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-30 10:36:36,916 [salt.state       ][INFO    ][33115] Completed state [/srv/glusterfs/nova_instances] at time 10:36:36.915798 duration_in_ms=0.679
2017-10-30 10:36:36,916 [salt.state       ][INFO    ][33115] Running state [/srv/glusterfs/keystone-credential-keys] at time 10:36:36.915964
2017-10-30 10:36:36,916 [salt.state       ][INFO    ][33115] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-30 10:36:36,917 [salt.state       ][INFO    ][33115] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-30 10:36:36,917 [salt.state       ][INFO    ][33115] Completed state [/srv/glusterfs/keystone-credential-keys] at time 10:36:36.916670 duration_in_ms=0.706
2017-10-30 10:36:36,972 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command ['git', '--version'] in directory '/root'
2017-10-30 10:36:37,054 [salt.state       ][INFO    ][33115] Running state [sleep 5] at time 10:36:37.054404
2017-10-30 10:36:37,055 [salt.state       ][INFO    ][33115] Executing state cmd.wait for sleep 5
2017-10-30 10:36:37,055 [salt.state       ][INFO    ][33115] No changes made for sleep 5
2017-10-30 10:36:37,055 [salt.state       ][INFO    ][33115] Completed state [sleep 5] at time 10:36:37.055145 duration_in_ms=0.742
2017-10-30 10:36:37,056 [salt.state       ][INFO    ][33115] Running state [192.168.10.143] at time 10:36:37.055689
2017-10-30 10:36:37,056 [salt.state       ][INFO    ][33115] Executing state glusterfs.peered for 192.168.10.143
2017-10-30 10:36:37,056 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:37,065 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:37,119 [salt.state       ][INFO    ][33115] Host 192.168.10.143 already peered
2017-10-30 10:36:37,120 [salt.state       ][INFO    ][33115] Completed state [192.168.10.143] at time 10:36:37.119555 duration_in_ms=63.866
2017-10-30 10:36:37,122 [salt.state       ][INFO    ][33115] Running state [192.168.10.142] at time 10:36:37.122419
2017-10-30 10:36:37,123 [salt.state       ][INFO    ][33115] Executing state glusterfs.peered for 192.168.10.142
2017-10-30 10:36:37,123 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:37,131 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:37,185 [salt.state       ][INFO    ][33115] Host 192.168.10.142 already peered
2017-10-30 10:36:37,185 [salt.state       ][INFO    ][33115] Completed state [192.168.10.142] at time 10:36:37.184861 duration_in_ms=62.442
2017-10-30 10:36:37,188 [salt.state       ][INFO    ][33115] Running state [192.168.10.141] at time 10:36:37.187772
2017-10-30 10:36:37,188 [salt.state       ][INFO    ][33115] Executing state glusterfs.peered for 192.168.10.141
2017-10-30 10:36:37,188 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:37,197 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:37,251 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:37,259 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:37,313 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:37,322 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:37,373 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:37,381 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:37,432 [salt.state       ][INFO    ][33115] Peering with localhost is not needed
2017-10-30 10:36:37,432 [salt.state       ][INFO    ][33115] Completed state [192.168.10.141] at time 10:36:37.432265 duration_in_ms=244.492
2017-10-30 10:36:37,433 [salt.state       ][INFO    ][33115] Running state [glance] at time 10:36:37.433239
2017-10-30 10:36:37,434 [salt.state       ][INFO    ][33115] Executing state glusterfs.created for glance
2017-10-30 10:36:37,434 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:37,442 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:37,496 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:37,504 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:37,562 [salt.state       ][INFO    ][33115] Volume glance already exists and is started.
2017-10-30 10:36:37,562 [salt.state       ][INFO    ][33115] Completed state [glance] at time 10:36:37.561721 duration_in_ms=128.482
2017-10-30 10:36:37,565 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 10:36:37.565197
2017-10-30 10:36:37,565 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-30 10:36:37,566 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-30 10:36:37,617 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:37,617 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 10:36:37.616832 duration_in_ms=51.635
2017-10-30 10:36:37,617 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 10:36:37.617383
2017-10-30 10:36:37,618 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-30 10:36:37,618 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-30 10:36:37,671 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:37,671 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 10:36:37.671435 duration_in_ms=54.052
2017-10-30 10:36:37,672 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 10:36:37.672097
2017-10-30 10:36:37,672 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-30 10:36:37,673 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-30 10:36:37,725 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:37,726 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 10:36:37.725561 duration_in_ms=53.463
2017-10-30 10:36:37,726 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 10:36:37.726065
2017-10-30 10:36:37,726 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-30 10:36:37,727 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-30 10:36:37,778 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:37,778 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 10:36:37.777919 duration_in_ms=51.854
2017-10-30 10:36:37,778 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 10:36:37.778431
2017-10-30 10:36:37,779 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-30 10:36:37,779 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-30 10:36:37,833 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:37,833 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 10:36:37.833436 duration_in_ms=55.005
2017-10-30 10:36:37,835 [salt.state       ][INFO    ][33115] Running state [glance] at time 10:36:37.834731
2017-10-30 10:36:37,835 [salt.state       ][INFO    ][33115] Executing state glusterfs.started for glance
2017-10-30 10:36:37,835 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:37,842 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:37,893 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:37,901 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:37,958 [salt.state       ][INFO    ][33115] Volume glance is already started
2017-10-30 10:36:37,958 [salt.state       ][INFO    ][33115] Completed state [glance] at time 10:36:37.958286 duration_in_ms=123.554
2017-10-30 10:36:37,959 [salt.state       ][INFO    ][33115] Running state [keystone-keys] at time 10:36:37.959380
2017-10-30 10:36:37,960 [salt.state       ][INFO    ][33115] Executing state glusterfs.created for keystone-keys
2017-10-30 10:36:37,960 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:37,968 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:38,018 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:38,025 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:38,082 [salt.state       ][INFO    ][33115] Volume keystone-keys already exists and is started.
2017-10-30 10:36:38,082 [salt.state       ][INFO    ][33115] Completed state [keystone-keys] at time 10:36:38.082286 duration_in_ms=122.906
2017-10-30 10:36:38,086 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 10:36:38.085920
2017-10-30 10:36:38,086 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-30 10:36:38,087 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-30 10:36:38,138 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:38,139 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 10:36:38.138464 duration_in_ms=52.542
2017-10-30 10:36:38,139 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:36:38.139204
2017-10-30 10:36:38,140 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-30 10:36:38,140 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-30 10:36:38,194 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:38,194 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:36:38.193927 duration_in_ms=54.722
2017-10-30 10:36:38,194 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:36:38.194442
2017-10-30 10:36:38,195 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-30 10:36:38,195 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-30 10:36:38,248 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:38,248 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:36:38.248105 duration_in_ms=53.663
2017-10-30 10:36:38,249 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 10:36:38.248613
2017-10-30 10:36:38,249 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-30 10:36:38,249 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-30 10:36:38,304 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:38,304 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 10:36:38.303977 duration_in_ms=55.364
2017-10-30 10:36:38,305 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 10:36:38.304831
2017-10-30 10:36:38,305 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-30 10:36:38,306 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-30 10:36:38,358 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:38,359 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 10:36:38.358626 duration_in_ms=53.795
2017-10-30 10:36:38,360 [salt.state       ][INFO    ][33115] Running state [keystone-keys] at time 10:36:38.359958
2017-10-30 10:36:38,360 [salt.state       ][INFO    ][33115] Executing state glusterfs.started for keystone-keys
2017-10-30 10:36:38,361 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:38,368 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:38,420 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:38,427 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:38,485 [salt.state       ][INFO    ][33115] Volume keystone-keys is already started
2017-10-30 10:36:38,485 [salt.state       ][INFO    ][33115] Completed state [keystone-keys] at time 10:36:38.485311 duration_in_ms=125.352
2017-10-30 10:36:38,487 [salt.state       ][INFO    ][33115] Running state [nova_instances] at time 10:36:38.486544
2017-10-30 10:36:38,487 [salt.state       ][INFO    ][33115] Executing state glusterfs.created for nova_instances
2017-10-30 10:36:38,487 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:38,495 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:38,545 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:38,554 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:38,609 [salt.state       ][INFO    ][33115] Volume nova_instances already exists and is started.
2017-10-30 10:36:38,610 [salt.state       ][INFO    ][33115] Completed state [nova_instances] at time 10:36:38.609543 duration_in_ms=122.999
2017-10-30 10:36:38,614 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 10:36:38.613875
2017-10-30 10:36:38,614 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-30 10:36:38,615 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-30 10:36:38,665 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:38,666 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 10:36:38.665692 duration_in_ms=51.816
2017-10-30 10:36:38,666 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 10:36:38.666234
2017-10-30 10:36:38,667 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-30 10:36:38,667 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-30 10:36:38,720 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:38,720 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 10:36:38.720248 duration_in_ms=54.014
2017-10-30 10:36:38,721 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 10:36:38.720813
2017-10-30 10:36:38,721 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-30 10:36:38,722 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-30 10:36:38,772 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:38,772 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 10:36:38.771991 duration_in_ms=51.178
2017-10-30 10:36:38,773 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 10:36:38.772590
2017-10-30 10:36:38,773 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-30 10:36:38,773 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-30 10:36:38,824 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:38,824 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 10:36:38.824335 duration_in_ms=51.744
2017-10-30 10:36:38,825 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 10:36:38.824905
2017-10-30 10:36:38,825 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-30 10:36:38,826 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-30 10:36:38,877 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:38,877 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 10:36:38.876896 duration_in_ms=51.991
2017-10-30 10:36:38,878 [salt.state       ][INFO    ][33115] Running state [nova_instances] at time 10:36:38.878145
2017-10-30 10:36:38,878 [salt.state       ][INFO    ][33115] Executing state glusterfs.started for nova_instances
2017-10-30 10:36:38,879 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:38,886 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:38,939 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:38,945 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:39,002 [salt.state       ][INFO    ][33115] Volume nova_instances is already started
2017-10-30 10:36:39,003 [salt.state       ][INFO    ][33115] Completed state [nova_instances] at time 10:36:39.002760 duration_in_ms=124.614
2017-10-30 10:36:39,004 [salt.state       ][INFO    ][33115] Running state [keystone-credential-keys] at time 10:36:39.003907
2017-10-30 10:36:39,004 [salt.state       ][INFO    ][33115] Executing state glusterfs.created for keystone-credential-keys
2017-10-30 10:36:39,005 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:39,013 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:39,067 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:39,073 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:39,130 [salt.state       ][INFO    ][33115] Volume keystone-credential-keys already exists and is started.
2017-10-30 10:36:39,131 [salt.state       ][INFO    ][33115] Completed state [keystone-credential-keys] at time 10:36:39.130455 duration_in_ms=126.547
2017-10-30 10:36:39,135 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 10:36:39.134539
2017-10-30 10:36:39,135 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-30 10:36:39,135 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-30 10:36:39,187 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:39,187 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 10:36:39.187434 duration_in_ms=52.894
2017-10-30 10:36:39,188 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:36:39.188093
2017-10-30 10:36:39,188 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-30 10:36:39,189 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-30 10:36:39,244 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:39,244 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:36:39.243730 duration_in_ms=55.637
2017-10-30 10:36:39,244 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 10:36:39.244244
2017-10-30 10:36:39,244 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-30 10:36:39,245 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-30 10:36:39,297 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:39,297 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 10:36:39.296904 duration_in_ms=52.66
2017-10-30 10:36:39,297 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:36:39.297460
2017-10-30 10:36:39,298 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-30 10:36:39,298 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-30 10:36:39,353 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:39,353 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:36:39.353217 duration_in_ms=55.758
2017-10-30 10:36:39,354 [salt.state       ][INFO    ][33115] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 10:36:39.353760
2017-10-30 10:36:39,354 [salt.state       ][INFO    ][33115] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-30 10:36:39,355 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-30 10:36:39,406 [salt.state       ][INFO    ][33115] unless execution succeeded
2017-10-30 10:36:39,407 [salt.state       ][INFO    ][33115] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 10:36:39.406507 duration_in_ms=52.745
2017-10-30 10:36:39,408 [salt.state       ][INFO    ][33115] Running state [keystone-credential-keys] at time 10:36:39.407818
2017-10-30 10:36:39,408 [salt.state       ][INFO    ][33115] Executing state glusterfs.started for keystone-credential-keys
2017-10-30 10:36:39,409 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:39,418 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:39,471 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --version' in directory '/root'
2017-10-30 10:36:39,479 [salt.loaded.int.module.cmdmod][INFO    ][33115] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-30 10:36:39,539 [salt.state       ][INFO    ][33115] Volume keystone-credential-keys is already started
2017-10-30 10:36:39,539 [salt.state       ][INFO    ][33115] Completed state [keystone-credential-keys] at time 10:36:39.539000 duration_in_ms=131.182
2017-10-30 10:36:39,541 [salt.minion      ][INFO    ][33115] Returning information for job: 20171030103635493454
2017-10-30 10:36:40,634 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command test.ping with jid 20171030103640619817
2017-10-30 10:36:40,646 [salt.minion      ][INFO    ][33498] Starting a new job with PID 33498
2017-10-30 10:36:40,682 [salt.minion      ][INFO    ][33498] Returning information for job: 20171030103640619817
2017-10-30 10:36:41,469 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command cmd.run with jid 20171030103641454059
2017-10-30 10:36:41,482 [salt.minion      ][INFO    ][33503] Starting a new job with PID 33503
2017-10-30 10:36:41,486 [salt.loaded.int.module.cmdmod][INFO    ][33503] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-30 10:36:41,604 [salt.minion      ][INFO    ][33503] Returning information for job: 20171030103641454059
2017-10-30 10:39:39,548 [salt.utils.schedule][INFO    ][24696] Running scheduled job: __mine_interval
2017-10-30 10:59:49,857 [salt.minion      ][INFO    ][24696] User sudo_ubuntu Executing command cp.push_dir with jid 20171030105949841940
2017-10-30 10:59:49,873 [salt.minion      ][INFO    ][33783] Starting a new job with PID 33783
