2017-09-12 10:57:04,041 [salt.cli.daemons ][WARNING ][2573] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-12 11:38:03,772 [salt.state       ][ERROR   ][3862] No contents found in top file
2017-09-12 11:38:21,739 [salt.utils.parsers][WARNING ][2573] Minion received a SIGTERM. Exiting.
2017-09-12 11:40:47,047 [salt.cli.daemons ][WARNING ][3251] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-12 11:45:04,258 [salt.transport.ipc][ERROR   ][3251] Exception occurred while handling stream: [Errno 0] Success
2017-09-12 11:45:38,849 [py.warnings      ][WARNING ][16323] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-09-12 11:57:17,421 [salt.loaded.int.module.cmdmod][ERROR   ][16323] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-12 11:57:17,421 [salt.loaded.int.module.cmdmod][ERROR   ][16323] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-12 11:57:23,681 [salt.loaded.int.module.cmdmod][ERROR   ][16323] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-12 11:57:23,681 [salt.loaded.int.module.cmdmod][ERROR   ][16323] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-12 11:57:31,653 [salt.loaded.int.module.cmdmod][ERROR   ][16323] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-12 11:57:31,654 [salt.loaded.int.module.cmdmod][ERROR   ][16323] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-12 11:57:40,414 [salt.loaded.int.module.cmdmod][ERROR   ][16323] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-12 11:57:40,415 [salt.loaded.int.module.cmdmod][ERROR   ][16323] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-12 11:57:48,381 [salt.loaded.int.module.cmdmod][ERROR   ][16323] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-12 11:57:48,381 [salt.loaded.int.module.cmdmod][ERROR   ][16323] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-12 11:57:54,743 [salt.loaded.int.module.cmdmod][ERROR   ][16323] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-09-12 11:57:58,326 [salt.state       ][ERROR   ][24283] No contents found in top file
2017-09-12 11:58:05,323 [salt.loaded.int.module.cmdmod][INFO    ][24714] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-12 11:58:05,329 [salt.loaded.int.module.cmdmod][INFO    ][24714] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-12 11:58:05,338 [salt.loaded.int.module.cmdmod][INFO    ][24714] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-12 11:58:05,346 [salt.utils.parsers][WARNING ][3251] Minion received a SIGTERM. Exiting.
2017-09-12 11:58:05,592 [salt.cli.daemons ][INFO    ][24830] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-09-12 11:58:06,103 [salt.minion      ][INFO    ][24830] Creating minion process manager
2017-09-12 11:58:06,103 [salt.cli.daemons ][WARNING ][24830] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-12 11:58:06,103 [salt.cli.daemons ][INFO    ][24830] The Salt Minion is starting up
2017-09-12 11:58:06,103 [salt.minion      ][INFO    ][24830] Minion is starting as user 'root'
2017-09-12 11:58:06,104 [salt.utils.event ][INFO    ][24830] Starting pull socket on /var/run/salt/minion/minion_event_0fd62c7a6e_pull.ipc
2017-09-12 11:58:07,005 [salt.loaded.int.module.cmdmod][INFO    ][24830] Executing command ['date', '+%z'] in directory '/root'
2017-09-12 11:58:07,016 [salt.utils.schedule][INFO    ][24830] Updating job settings for scheduled job: __mine_interval
2017-09-12 11:58:07,018 [salt.minion      ][INFO    ][24830] Added mine.update to scheduler
2017-09-12 11:58:07,135 [salt.minion      ][INFO    ][24830] Minion is ready to receive requests!
2017-09-12 11:58:08,136 [salt.utils.schedule][INFO    ][24830] Running scheduled job: __mine_interval
2017-09-12 11:58:14,687 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command saltutil.find_job with jid 20170912115814676468
2017-09-12 11:58:14,702 [salt.minion      ][INFO    ][24929] Starting a new job with PID 24929
2017-09-12 11:58:14,711 [salt.minion      ][INFO    ][24929] Returning information for job: 20170912115814676468
2017-09-12 11:58:25,670 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command pillar.get with jid 20170912115825663938
2017-09-12 11:58:25,683 [salt.minion      ][INFO    ][24934] Starting a new job with PID 24934
2017-09-12 11:58:25,686 [salt.minion      ][INFO    ][24934] Returning information for job: 20170912115825663938
2017-09-12 11:59:19,967 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170912115919957732
2017-09-12 11:59:19,985 [salt.minion      ][INFO    ][24966] Starting a new job with PID 24966
2017-09-12 11:59:24,381 [salt.state       ][INFO    ][24966] Loading fresh modules for state activity
2017-09-12 11:59:24,401 [salt.state       ][ERROR   ][24966] No contents found in top file
2017-09-12 11:59:24,402 [salt.utils.extmods][INFO    ][24966] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-12 11:59:24,405 [salt.utils.extmods][INFO    ][24966] Syncing beacons for environment 'base'
2017-09-12 11:59:24,405 [salt.utils.extmods][INFO    ][24966] Loading cache from salt://_beacons, for base)
2017-09-12 11:59:24,405 [salt.fileclient  ][INFO    ][24966] Caching directory '_beacons/' for environment 'base'
2017-09-12 11:59:24,488 [salt.utils.extmods][INFO    ][24966] Syncing modules for environment 'base'
2017-09-12 11:59:24,488 [salt.utils.extmods][INFO    ][24966] Loading cache from salt://_modules, for base)
2017-09-12 11:59:24,488 [salt.fileclient  ][INFO    ][24966] Caching directory '_modules/' for environment 'base'
2017-09-12 11:59:24,923 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-12 11:59:24,934 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-12 11:59:24,960 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-12 11:59:25,099 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-12 11:59:25,138 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-12 11:59:25,155 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-12 11:59:25,171 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-12 11:59:25,219 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-12 11:59:25,235 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-12 11:59:25,252 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-12 11:59:25,277 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-12 11:59:25,304 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-12 11:59:25,339 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-12 11:59:25,363 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-12 11:59:25,385 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-12 11:59:25,406 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-12 11:59:25,421 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-12 11:59:25,483 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-12 11:59:25,503 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-12 11:59:25,518 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-12 11:59:25,539 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-12 11:59:25,556 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-12 11:59:25,566 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-12 11:59:25,587 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-12 11:59:25,612 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-12 11:59:25,625 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-12 11:59:25,636 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-12 11:59:25,680 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-12 11:59:25,692 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-12 11:59:25,740 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-12 11:59:25,770 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-12 11:59:25,808 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-12 11:59:25,810 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-12 11:59:25,810 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-12 11:59:25,811 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-12 11:59:25,811 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-12 11:59:25,811 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-12 11:59:25,811 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-12 11:59:25,812 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-12 11:59:25,812 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-12 11:59:25,812 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-12 11:59:25,812 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-12 11:59:25,812 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-12 11:59:25,813 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-12 11:59:25,813 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-12 11:59:25,813 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-12 11:59:25,813 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-12 11:59:25,813 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-12 11:59:25,813 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-12 11:59:25,814 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-12 11:59:25,814 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-12 11:59:25,814 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-12 11:59:25,814 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-12 11:59:25,814 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-12 11:59:25,815 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-12 11:59:25,815 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-12 11:59:25,815 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-12 11:59:25,816 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-12 11:59:25,816 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-12 11:59:25,816 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-12 11:59:25,816 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-12 11:59:25,816 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-12 11:59:25,816 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-12 11:59:25,817 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-09-12 11:59:25,817 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-12 11:59:25,817 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-12 11:59:25,821 [salt.utils.extmods][INFO    ][24966] Syncing states for environment 'base'
2017-09-12 11:59:25,821 [salt.utils.extmods][INFO    ][24966] Loading cache from salt://_states, for base)
2017-09-12 11:59:25,821 [salt.fileclient  ][INFO    ][24966] Caching directory '_states/' for environment 'base'
2017-09-12 11:59:25,897 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-12 11:59:25,918 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-12 11:59:26,045 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-12 11:59:26,059 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-12 11:59:26,096 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-12 11:59:26,139 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-12 11:59:26,147 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-12 11:59:26,230 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-12 11:59:26,244 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-12 11:59:26,270 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-12 11:59:26,278 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-12 11:59:26,290 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-12 11:59:26,318 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-12 11:59:26,331 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-12 11:59:26,340 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-12 11:59:26,378 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-12 11:59:26,390 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-12 11:59:26,428 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-12 11:59:26,456 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-12 11:59:26,471 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-12 11:59:26,493 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-12 11:59:26,506 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-12 11:59:26,636 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-12 11:59:26,664 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-12 11:59:26,674 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-12 11:59:26,685 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-12 11:59:26,693 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-12 11:59:26,701 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-12 11:59:26,713 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-12 11:59:26,716 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-12 11:59:26,716 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-12 11:59:26,716 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-12 11:59:26,716 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-12 11:59:26,717 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-12 11:59:26,717 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-12 11:59:26,717 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-12 11:59:26,717 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-12 11:59:26,717 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-12 11:59:26,718 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-12 11:59:26,718 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-12 11:59:26,718 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-12 11:59:26,718 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-12 11:59:26,718 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-12 11:59:26,719 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-12 11:59:26,719 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-12 11:59:26,719 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-12 11:59:26,719 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-12 11:59:26,719 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-12 11:59:26,720 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-12 11:59:26,720 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-12 11:59:26,720 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-12 11:59:26,720 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-12 11:59:26,720 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-12 11:59:26,720 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-12 11:59:26,721 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-12 11:59:26,721 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-12 11:59:26,721 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-12 11:59:26,721 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-12 11:59:26,721 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-12 11:59:26,723 [salt.utils.extmods][INFO    ][24966] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-12 11:59:26,725 [salt.utils.extmods][INFO    ][24966] Syncing sdb for environment 'base'
2017-09-12 11:59:26,725 [salt.utils.extmods][INFO    ][24966] Loading cache from salt://_sdb, for base)
2017-09-12 11:59:26,726 [salt.fileclient  ][INFO    ][24966] Caching directory '_sdb/' for environment 'base'
2017-09-12 11:59:26,760 [salt.utils.extmods][INFO    ][24966] Syncing grains for environment 'base'
2017-09-12 11:59:26,760 [salt.utils.extmods][INFO    ][24966] Loading cache from salt://_grains, for base)
2017-09-12 11:59:26,760 [salt.fileclient  ][INFO    ][24966] Caching directory '_grains/' for environment 'base'
2017-09-12 11:59:26,839 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-12 11:59:26,850 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-12 11:59:26,873 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-12 11:59:26,884 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-12 11:59:26,942 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-12 11:59:27,064 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-12 11:59:27,111 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-12 11:59:27,194 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-12 11:59:27,204 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-12 11:59:27,242 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-12 11:59:27,260 [salt.fileclient  ][INFO    ][24966] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-12 11:59:27,263 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-12 11:59:27,263 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-12 11:59:27,263 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-12 11:59:27,263 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-12 11:59:27,264 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-12 11:59:27,264 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-12 11:59:27,264 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-12 11:59:27,264 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-12 11:59:27,264 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-12 11:59:27,264 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-12 11:59:27,265 [salt.utils.extmods][INFO    ][24966] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-12 11:59:27,266 [salt.utils.extmods][INFO    ][24966] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-12 11:59:27,268 [salt.utils.extmods][INFO    ][24966] Syncing renderers for environment 'base'
2017-09-12 11:59:27,269 [salt.utils.extmods][INFO    ][24966] Loading cache from salt://_renderers, for base)
2017-09-12 11:59:27,269 [salt.fileclient  ][INFO    ][24966] Caching directory '_renderers/' for environment 'base'
2017-09-12 11:59:27,337 [salt.utils.extmods][INFO    ][24966] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-12 11:59:27,339 [salt.utils.extmods][INFO    ][24966] Syncing returners for environment 'base'
2017-09-12 11:59:27,339 [salt.utils.extmods][INFO    ][24966] Loading cache from salt://_returners, for base)
2017-09-12 11:59:27,340 [salt.fileclient  ][INFO    ][24966] Caching directory '_returners/' for environment 'base'
2017-09-12 11:59:27,451 [salt.utils.extmods][INFO    ][24966] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-12 11:59:27,453 [salt.utils.extmods][INFO    ][24966] Syncing output for environment 'base'
2017-09-12 11:59:27,453 [salt.utils.extmods][INFO    ][24966] Loading cache from salt://_output, for base)
2017-09-12 11:59:27,453 [salt.fileclient  ][INFO    ][24966] Caching directory '_output/' for environment 'base'
2017-09-12 11:59:27,497 [salt.utils.extmods][INFO    ][24966] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-12 11:59:27,500 [salt.utils.extmods][INFO    ][24966] Syncing utils for environment 'base'
2017-09-12 11:59:27,500 [salt.utils.extmods][INFO    ][24966] Loading cache from salt://_utils, for base)
2017-09-12 11:59:27,500 [salt.fileclient  ][INFO    ][24966] Caching directory '_utils/' for environment 'base'
2017-09-12 11:59:27,562 [salt.utils.extmods][INFO    ][24966] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-12 11:59:27,564 [salt.utils.extmods][INFO    ][24966] Syncing log_handlers for environment 'base'
2017-09-12 11:59:27,564 [salt.utils.extmods][INFO    ][24966] Loading cache from salt://_log_handlers, for base)
2017-09-12 11:59:27,564 [salt.fileclient  ][INFO    ][24966] Caching directory '_log_handlers/' for environment 'base'
2017-09-12 11:59:27,618 [salt.utils.extmods][INFO    ][24966] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-12 11:59:27,621 [salt.utils.extmods][INFO    ][24966] Syncing proxy for environment 'base'
2017-09-12 11:59:27,621 [salt.utils.extmods][INFO    ][24966] Loading cache from salt://_proxy, for base)
2017-09-12 11:59:27,621 [salt.fileclient  ][INFO    ][24966] Caching directory '_proxy/' for environment 'base'
2017-09-12 11:59:27,646 [salt.utils.extmods][INFO    ][24966] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-12 11:59:27,649 [salt.utils.extmods][INFO    ][24966] Syncing engines for environment 'base'
2017-09-12 11:59:27,649 [salt.utils.extmods][INFO    ][24966] Loading cache from salt://_engines, for base)
2017-09-12 11:59:27,649 [salt.fileclient  ][INFO    ][24966] Caching directory '_engines/' for environment 'base'
2017-09-12 11:59:27,679 [salt.minion      ][INFO    ][24966] Returning information for job: 20170912115919957732
2017-09-12 12:11:06,108 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command test.ping with jid 20170912121106098930
2017-09-12 12:11:06,127 [salt.minion      ][INFO    ][25236] Starting a new job with PID 25236
2017-09-12 12:11:06,166 [salt.minion      ][INFO    ][25236] Returning information for job: 20170912121106098930
2017-09-12 12:14:32,238 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command state.sls with jid 20170912121432229289
2017-09-12 12:14:32,254 [salt.minion      ][INFO    ][25298] Starting a new job with PID 25298
2017-09-12 12:14:32,641 [salt.state       ][INFO    ][25298] Loading fresh modules for state activity
2017-09-12 12:14:32,731 [salt.fileclient  ][INFO    ][25298] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-12 12:14:32,748 [salt.fileclient  ][INFO    ][25298] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-12 12:14:32,771 [salt.fileclient  ][INFO    ][25298] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-12 12:14:33,065 [salt.state       ][INFO    ][25298] Running state [lsof] at time 12:14:33.065294
2017-09-12 12:14:33,066 [salt.state       ][INFO    ][25298] Executing state pkg.installed for lsof
2017-09-12 12:14:33,066 [salt.loaded.int.module.cmdmod][INFO    ][25298] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-12 12:14:33,359 [salt.state       ][INFO    ][25298] Package lsof is already installed
2017-09-12 12:14:33,359 [salt.state       ][INFO    ][25298] Completed state [lsof] at time 12:14:33.358876 duration_in_ms=293.582
2017-09-12 12:14:33,359 [salt.state       ][INFO    ][25298] Running state [keepalived] at time 12:14:33.359059
2017-09-12 12:14:33,359 [salt.state       ][INFO    ][25298] Executing state pkg.installed for keepalived
2017-09-12 12:14:33,374 [salt.loaded.int.module.cmdmod][INFO    ][25298] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-12 12:14:37,204 [salt.loaded.int.module.cmdmod][INFO    ][25298] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-09-12 12:14:42,290 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command saltutil.find_job with jid 20170912121442279193
2017-09-12 12:14:42,303 [salt.minion      ][INFO    ][26615] Starting a new job with PID 26615
2017-09-12 12:14:42,319 [salt.minion      ][INFO    ][26615] Returning information for job: 20170912121442279193
2017-09-12 12:14:44,744 [salt.loaded.int.module.cmdmod][INFO    ][25298] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-12 12:14:44,768 [salt.state       ][INFO    ][25298] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-09-12 12:14:44,776 [salt.state       ][INFO    ][25298] Loading fresh modules for state activity
2017-09-12 12:14:44,789 [salt.state       ][INFO    ][25298] Completed state [keepalived] at time 12:14:44.788569 duration_in_ms=11429.509
2017-09-12 12:14:44,791 [salt.state       ][INFO    ][25298] Running state [/etc/keepalived/keepalived.conf] at time 12:14:44.791249
2017-09-12 12:14:44,792 [salt.state       ][INFO    ][25298] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-12 12:14:44,824 [salt.fileclient  ][INFO    ][25298] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-12 12:14:44,857 [salt.fileclient  ][INFO    ][25298] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-12 12:14:44,863 [salt.state       ][INFO    ][25298] File changed:
New file
2017-09-12 12:14:44,863 [salt.state       ][INFO    ][25298] Completed state [/etc/keepalived/keepalived.conf] at time 12:14:44.863022 duration_in_ms=71.773
2017-09-12 12:14:44,917 [salt.state       ][INFO    ][25298] Running state [keepalived] at time 12:14:44.916552
2017-09-12 12:14:44,917 [salt.state       ][INFO    ][25298] Executing state service.running for keepalived
2017-09-12 12:14:44,918 [salt.loaded.int.module.cmdmod][INFO    ][25298] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-12 12:14:44,927 [salt.loaded.int.module.cmdmod][INFO    ][25298] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-12 12:14:44,934 [salt.loaded.int.module.cmdmod][INFO    ][25298] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-12 12:14:44,942 [salt.loaded.int.module.cmdmod][INFO    ][25298] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-12 12:14:44,950 [salt.loaded.int.module.cmdmod][INFO    ][25298] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-12 12:14:45,026 [salt.loaded.int.module.cmdmod][INFO    ][25298] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-12 12:14:45,033 [salt.loaded.int.module.cmdmod][INFO    ][25298] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-12 12:14:45,041 [salt.loaded.int.module.cmdmod][INFO    ][25298] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-12 12:14:45,047 [salt.state       ][INFO    ][25298] {'keepalived': True}
2017-09-12 12:14:45,047 [salt.state       ][INFO    ][25298] Completed state [keepalived] at time 12:14:45.047329 duration_in_ms=130.778
2017-09-12 12:14:45,048 [salt.minion      ][INFO    ][25298] Returning information for job: 20170912121432229289
2017-09-12 12:14:59,255 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command pillar.get with jid 20170912121459251987
2017-09-12 12:14:59,276 [salt.minion      ][INFO    ][26898] Starting a new job with PID 26898
2017-09-12 12:14:59,281 [salt.minion      ][INFO    ][26898] Returning information for job: 20170912121459251987
2017-09-12 12:20:29,509 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command state.sls with jid 20170912122029499415
2017-09-12 12:20:29,521 [salt.minion      ][INFO    ][27003] Starting a new job with PID 27003
2017-09-12 12:20:31,996 [salt.state       ][INFO    ][27003] Loading fresh modules for state activity
2017-09-12 12:20:32,016 [salt.fileclient  ][INFO    ][27003] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-12 12:20:32,036 [salt.fileclient  ][INFO    ][27003] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-12 12:20:32,304 [salt.state       ][INFO    ][27003] Running state [attr] at time 12:20:32.303717
2017-09-12 12:20:32,304 [salt.state       ][INFO    ][27003] Executing state pkg.installed for attr
2017-09-12 12:20:32,304 [salt.loaded.int.module.cmdmod][INFO    ][27003] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-12 12:20:32,585 [salt.loaded.int.module.cmdmod][INFO    ][27003] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-12 12:20:35,752 [salt.loaded.int.module.cmdmod][INFO    ][27003] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-09-12 12:20:37,925 [salt.loaded.int.module.cmdmod][INFO    ][27003] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-12 12:20:37,948 [salt.state       ][INFO    ][27003] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-12 12:20:37,957 [salt.state       ][INFO    ][27003] Loading fresh modules for state activity
2017-09-12 12:20:37,969 [salt.state       ][INFO    ][27003] Completed state [attr] at time 12:20:37.968650 duration_in_ms=5664.933
2017-09-12 12:20:37,974 [salt.state       ][INFO    ][27003] Running state [glusterfs-server] at time 12:20:37.973724
2017-09-12 12:20:37,974 [salt.state       ][INFO    ][27003] Executing state pkg.installed for glusterfs-server
2017-09-12 12:20:38,158 [salt.loaded.int.module.cmdmod][INFO    ][27003] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-09-12 12:20:39,604 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command saltutil.find_job with jid 20170912122039593206
2017-09-12 12:20:39,620 [salt.minion      ][INFO    ][28006] Starting a new job with PID 28006
2017-09-12 12:20:39,631 [salt.minion      ][INFO    ][28006] Returning information for job: 20170912122039593206
2017-09-12 12:20:49,810 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command saltutil.find_job with jid 20170912122049798702
2017-09-12 12:20:49,824 [salt.minion      ][INFO    ][30749] Starting a new job with PID 30749
2017-09-12 12:20:49,835 [salt.minion      ][INFO    ][30749] Returning information for job: 20170912122049798702
2017-09-12 12:20:55,551 [salt.loaded.int.module.cmdmod][INFO    ][27003] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-12 12:20:55,576 [salt.state       ][INFO    ][27003] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-09-12 12:20:55,583 [salt.state       ][INFO    ][27003] Loading fresh modules for state activity
2017-09-12 12:20:55,595 [salt.state       ][INFO    ][27003] Completed state [glusterfs-server] at time 12:20:55.594940 duration_in_ms=17621.215
2017-09-12 12:20:55,599 [salt.state       ][INFO    ][27003] Running state [bc] at time 12:20:55.599132
2017-09-12 12:20:55,599 [salt.state       ][INFO    ][27003] Executing state pkg.installed for bc
2017-09-12 12:20:55,830 [salt.loaded.int.module.cmdmod][INFO    ][27003] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-09-12 12:20:58,612 [salt.loaded.int.module.cmdmod][INFO    ][27003] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-12 12:20:58,635 [salt.state       ][INFO    ][27003] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-12 12:20:58,642 [salt.state       ][INFO    ][27003] Loading fresh modules for state activity
2017-09-12 12:20:58,654 [salt.state       ][INFO    ][27003] Completed state [bc] at time 12:20:58.653955 duration_in_ms=3054.821
2017-09-12 12:20:58,710 [salt.state       ][INFO    ][27003] Running state [glusterfs-server] at time 12:20:58.710396
2017-09-12 12:20:58,711 [salt.state       ][INFO    ][27003] Executing state service.running for glusterfs-server
2017-09-12 12:20:58,712 [salt.loaded.int.module.cmdmod][INFO    ][27003] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-12 12:20:58,721 [salt.loaded.int.module.cmdmod][INFO    ][27003] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-12 12:20:58,727 [salt.loaded.int.module.cmdmod][INFO    ][27003] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-12 12:20:58,734 [salt.state       ][INFO    ][27003] The service glusterfs-server is already running
2017-09-12 12:20:58,735 [salt.state       ][INFO    ][27003] Completed state [glusterfs-server] at time 12:20:58.734634 duration_in_ms=24.238
2017-09-12 12:20:58,736 [salt.state       ][INFO    ][27003] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:20:58.735928
2017-09-12 12:20:58,736 [salt.state       ][INFO    ][27003] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-12 12:20:58,747 [salt.state       ][INFO    ][27003] File changed:
New file
2017-09-12 12:20:58,747 [salt.state       ][INFO    ][27003] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:20:58.746973 duration_in_ms=11.045
2017-09-12 12:20:58,747 [salt.state       ][INFO    ][27003] Running state [/srv/glusterfs/glance] at time 12:20:58.747201
2017-09-12 12:20:58,747 [salt.state       ][INFO    ][27003] Executing state file.directory for /srv/glusterfs/glance
2017-09-12 12:20:58,748 [salt.state       ][INFO    ][27003] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-12 12:20:58,748 [salt.state       ][INFO    ][27003] Completed state [/srv/glusterfs/glance] at time 12:20:58.748449 duration_in_ms=1.249
2017-09-12 12:20:58,749 [salt.state       ][INFO    ][27003] Running state [/srv/glusterfs/keystone-keys] at time 12:20:58.748670
2017-09-12 12:20:58,749 [salt.state       ][INFO    ][27003] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-12 12:20:58,749 [salt.state       ][INFO    ][27003] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-12 12:20:58,749 [salt.state       ][INFO    ][27003] Completed state [/srv/glusterfs/keystone-keys] at time 12:20:58.749320 duration_in_ms=0.65
2017-09-12 12:20:58,749 [salt.state       ][INFO    ][27003] Running state [/srv/glusterfs/keystone-credential-keys] at time 12:20:58.749463
2017-09-12 12:20:58,750 [salt.state       ][INFO    ][27003] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-12 12:20:58,750 [salt.state       ][INFO    ][27003] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-12 12:20:58,750 [salt.state       ][INFO    ][27003] Completed state [/srv/glusterfs/keystone-credential-keys] at time 12:20:58.750097 duration_in_ms=0.634
2017-09-12 12:20:58,751 [salt.minion      ][INFO    ][27003] Returning information for job: 20170912122029499415
2017-09-12 12:20:59,860 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command test.ping with jid 20170912122059855612
2017-09-12 12:20:59,872 [salt.minion      ][INFO    ][31755] Starting a new job with PID 31755
2017-09-12 12:20:59,896 [salt.minion      ][INFO    ][31755] Returning information for job: 20170912122059855612
2017-09-12 12:21:35,230 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command state.sls with jid 20170912122135219983
2017-09-12 12:21:35,245 [salt.minion      ][INFO    ][31921] Starting a new job with PID 31921
2017-09-12 12:21:35,705 [salt.state       ][INFO    ][31921] Loading fresh modules for state activity
2017-09-12 12:21:35,728 [salt.fileclient  ][INFO    ][31921] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-12 12:21:35,759 [salt.fileclient  ][INFO    ][31921] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-12 12:21:35,810 [salt.fileclient  ][INFO    ][31921] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-12 12:21:35,830 [salt.fileclient  ][INFO    ][31921] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-12 12:21:36,094 [salt.state       ][INFO    ][31921] Running state [attr] at time 12:21:36.093655
2017-09-12 12:21:36,094 [salt.state       ][INFO    ][31921] Executing state pkg.installed for attr
2017-09-12 12:21:36,094 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-12 12:21:36,378 [salt.state       ][INFO    ][31921] Package attr is already installed
2017-09-12 12:21:36,379 [salt.state       ][INFO    ][31921] Completed state [attr] at time 12:21:36.378626 duration_in_ms=284.97
2017-09-12 12:21:36,379 [salt.state       ][INFO    ][31921] Running state [glusterfs-server] at time 12:21:36.378802
2017-09-12 12:21:36,379 [salt.state       ][INFO    ][31921] Executing state pkg.installed for glusterfs-server
2017-09-12 12:21:36,382 [salt.state       ][INFO    ][31921] Package glusterfs-server is already installed
2017-09-12 12:21:36,382 [salt.state       ][INFO    ][31921] Completed state [glusterfs-server] at time 12:21:36.381622 duration_in_ms=2.819
2017-09-12 12:21:36,382 [salt.state       ][INFO    ][31921] Running state [bc] at time 12:21:36.381754
2017-09-12 12:21:36,382 [salt.state       ][INFO    ][31921] Executing state pkg.installed for bc
2017-09-12 12:21:36,384 [salt.state       ][INFO    ][31921] Package bc is already installed
2017-09-12 12:21:36,385 [salt.state       ][INFO    ][31921] Completed state [bc] at time 12:21:36.384484 duration_in_ms=2.729
2017-09-12 12:21:36,385 [salt.state       ][INFO    ][31921] Running state [glusterfs-server] at time 12:21:36.385211
2017-09-12 12:21:36,385 [salt.state       ][INFO    ][31921] Executing state service.running for glusterfs-server
2017-09-12 12:21:36,386 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-12 12:21:36,395 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-12 12:21:36,439 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-12 12:21:36,451 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-12 12:21:36,456 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-12 12:21:36,465 [salt.state       ][INFO    ][31921] The service glusterfs-server is already running
2017-09-12 12:21:36,466 [salt.state       ][INFO    ][31921] Completed state [glusterfs-server] at time 12:21:36.465634 duration_in_ms=80.423
2017-09-12 12:21:36,467 [salt.state       ][INFO    ][31921] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:21:36.467332
2017-09-12 12:21:36,468 [salt.state       ][INFO    ][31921] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-12 12:21:36,476 [salt.state       ][INFO    ][31921] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-12 12:21:36,477 [salt.state       ][INFO    ][31921] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:21:36.476520 duration_in_ms=9.189
2017-09-12 12:21:36,477 [salt.state       ][INFO    ][31921] Running state [/srv/glusterfs/glance] at time 12:21:36.476740
2017-09-12 12:21:36,477 [salt.state       ][INFO    ][31921] Executing state file.directory for /srv/glusterfs/glance
2017-09-12 12:21:36,477 [salt.state       ][INFO    ][31921] Directory /srv/glusterfs/glance is in the correct state
2017-09-12 12:21:36,478 [salt.state       ][INFO    ][31921] Completed state [/srv/glusterfs/glance] at time 12:21:36.477507 duration_in_ms=0.767
2017-09-12 12:21:36,478 [salt.state       ][INFO    ][31921] Running state [/srv/glusterfs/keystone-keys] at time 12:21:36.477689
2017-09-12 12:21:36,478 [salt.state       ][INFO    ][31921] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-12 12:21:36,478 [salt.state       ][INFO    ][31921] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-12 12:21:36,478 [salt.state       ][INFO    ][31921] Completed state [/srv/glusterfs/keystone-keys] at time 12:21:36.478449 duration_in_ms=0.761
2017-09-12 12:21:36,479 [salt.state       ][INFO    ][31921] Running state [/srv/glusterfs/keystone-credential-keys] at time 12:21:36.478633
2017-09-12 12:21:36,479 [salt.state       ][INFO    ][31921] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-12 12:21:36,479 [salt.state       ][INFO    ][31921] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-12 12:21:36,479 [salt.state       ][INFO    ][31921] Completed state [/srv/glusterfs/keystone-credential-keys] at time 12:21:36.479359 duration_in_ms=0.727
2017-09-12 12:21:36,533 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command ['git', '--version'] in directory '/root'
2017-09-12 12:21:36,581 [salt.state       ][INFO    ][31921] Running state [sleep 5] at time 12:21:36.580843
2017-09-12 12:21:36,581 [salt.state       ][INFO    ][31921] Executing state cmd.wait for sleep 5
2017-09-12 12:21:36,581 [salt.state       ][INFO    ][31921] No changes made for sleep 5
2017-09-12 12:21:36,581 [salt.state       ][INFO    ][31921] Completed state [sleep 5] at time 12:21:36.581447 duration_in_ms=0.605
2017-09-12 12:21:36,582 [salt.state       ][INFO    ][31921] Running state [10.167.4.141] at time 12:21:36.581832
2017-09-12 12:21:36,582 [salt.state       ][INFO    ][31921] Executing state glusterfs.peered for 10.167.4.141
2017-09-12 12:21:36,582 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:36,591 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:36,640 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:36,649 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:36,698 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:36,705 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:36,753 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:36,763 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:36,815 [salt.state       ][INFO    ][31921] Peering with localhost is not needed
2017-09-12 12:21:36,815 [salt.state       ][INFO    ][31921] Completed state [10.167.4.141] at time 12:21:36.815078 duration_in_ms=233.246
2017-09-12 12:21:36,817 [salt.state       ][INFO    ][31921] Running state [10.167.4.142] at time 12:21:36.817155
2017-09-12 12:21:36,817 [salt.state       ][INFO    ][31921] Executing state glusterfs.peered for 10.167.4.142
2017-09-12 12:21:36,818 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:36,826 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:36,877 [salt.state       ][INFO    ][31921] Host 10.167.4.142 already peered
2017-09-12 12:21:36,877 [salt.state       ][INFO    ][31921] Completed state [10.167.4.142] at time 12:21:36.877001 duration_in_ms=59.845
2017-09-12 12:21:36,879 [salt.state       ][INFO    ][31921] Running state [10.167.4.143] at time 12:21:36.879145
2017-09-12 12:21:36,879 [salt.state       ][INFO    ][31921] Executing state glusterfs.peered for 10.167.4.143
2017-09-12 12:21:36,880 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:36,888 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:36,937 [salt.state       ][INFO    ][31921] Host 10.167.4.143 already peered
2017-09-12 12:21:36,937 [salt.state       ][INFO    ][31921] Completed state [10.167.4.143] at time 12:21:36.936813 duration_in_ms=57.668
2017-09-12 12:21:36,938 [salt.state       ][INFO    ][31921] Running state [glance] at time 12:21:36.937494
2017-09-12 12:21:36,938 [salt.state       ][INFO    ][31921] Executing state glusterfs.created for glance
2017-09-12 12:21:36,938 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:36,946 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:37,004 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:37,012 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:37,062 [salt.state       ][INFO    ][31921] Volume glance already exists and is started.
2017-09-12 12:21:37,062 [salt.state       ][INFO    ][31921] Completed state [glance] at time 12:21:37.061991 duration_in_ms=124.496
2017-09-12 12:21:37,065 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 12:21:37.064480
2017-09-12 12:21:37,065 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-12 12:21:37,065 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-12 12:21:37,113 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:37,113 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 12:21:37.113021 duration_in_ms=48.54
2017-09-12 12:21:37,113 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 12:21:37.113417
2017-09-12 12:21:37,114 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-12 12:21:37,114 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-12 12:21:37,162 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:37,162 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 12:21:37.161987 duration_in_ms=48.569
2017-09-12 12:21:37,162 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 12:21:37.162402
2017-09-12 12:21:37,163 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-12 12:21:37,163 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-12 12:21:37,215 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:37,216 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 12:21:37.215590 duration_in_ms=53.188
2017-09-12 12:21:37,216 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 12:21:37.215945
2017-09-12 12:21:37,216 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-12 12:21:37,217 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-12 12:21:37,264 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:37,264 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 12:21:37.263796 duration_in_ms=47.85
2017-09-12 12:21:37,264 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 12:21:37.264197
2017-09-12 12:21:37,264 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-12 12:21:37,265 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-12 12:21:37,316 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:37,316 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 12:21:37.316435 duration_in_ms=52.237
2017-09-12 12:21:37,317 [salt.state       ][INFO    ][31921] Running state [glance] at time 12:21:37.317220
2017-09-12 12:21:37,317 [salt.state       ][INFO    ][31921] Executing state glusterfs.started for glance
2017-09-12 12:21:37,318 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:37,326 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:37,373 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:37,381 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:37,433 [salt.state       ][INFO    ][31921] Volume glance is already started
2017-09-12 12:21:37,434 [salt.state       ][INFO    ][31921] Completed state [glance] at time 12:21:37.433670 duration_in_ms=116.45
2017-09-12 12:21:37,435 [salt.state       ][INFO    ][31921] Running state [keystone-keys] at time 12:21:37.434511
2017-09-12 12:21:37,435 [salt.state       ][INFO    ][31921] Executing state glusterfs.created for keystone-keys
2017-09-12 12:21:37,435 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:37,444 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:37,492 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:37,500 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:37,554 [salt.state       ][INFO    ][31921] Volume keystone-keys already exists and is started.
2017-09-12 12:21:37,554 [salt.state       ][INFO    ][31921] Completed state [keystone-keys] at time 12:21:37.554018 duration_in_ms=119.506
2017-09-12 12:21:37,556 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 12:21:37.556458
2017-09-12 12:21:37,557 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-12 12:21:37,557 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-12 12:21:37,603 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:37,603 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 12:21:37.603329 duration_in_ms=46.871
2017-09-12 12:21:37,604 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:21:37.603734
2017-09-12 12:21:37,604 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-12 12:21:37,604 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-12 12:21:37,650 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:37,650 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:21:37.650418 duration_in_ms=46.682
2017-09-12 12:21:37,651 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 12:21:37.650889
2017-09-12 12:21:37,651 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-12 12:21:37,652 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-12 12:21:37,699 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:37,700 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 12:21:37.699566 duration_in_ms=48.677
2017-09-12 12:21:37,700 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 12:21:37.699964
2017-09-12 12:21:37,700 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-12 12:21:37,701 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-12 12:21:37,751 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:37,751 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 12:21:37.750823 duration_in_ms=50.859
2017-09-12 12:21:37,751 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:21:37.751200
2017-09-12 12:21:37,751 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-12 12:21:37,752 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-12 12:21:37,798 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:37,798 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:21:37.798127 duration_in_ms=46.927
2017-09-12 12:21:37,799 [salt.state       ][INFO    ][31921] Running state [keystone-keys] at time 12:21:37.798947
2017-09-12 12:21:37,799 [salt.state       ][INFO    ][31921] Executing state glusterfs.started for keystone-keys
2017-09-12 12:21:37,800 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:37,808 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:37,858 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:37,866 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:37,917 [salt.state       ][INFO    ][31921] Volume keystone-keys is already started
2017-09-12 12:21:37,917 [salt.state       ][INFO    ][31921] Completed state [keystone-keys] at time 12:21:37.916977 duration_in_ms=118.03
2017-09-12 12:21:37,918 [salt.state       ][INFO    ][31921] Running state [keystone-credential-keys] at time 12:21:37.917929
2017-09-12 12:21:37,918 [salt.state       ][INFO    ][31921] Executing state glusterfs.created for keystone-credential-keys
2017-09-12 12:21:37,919 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:37,927 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:37,976 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:37,985 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:38,036 [salt.state       ][INFO    ][31921] Volume keystone-credential-keys already exists and is started.
2017-09-12 12:21:38,037 [salt.state       ][INFO    ][31921] Completed state [keystone-credential-keys] at time 12:21:38.036659 duration_in_ms=118.73
2017-09-12 12:21:38,039 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 12:21:38.039342
2017-09-12 12:21:38,040 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-12 12:21:38,040 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-12 12:21:38,089 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:38,089 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 12:21:38.088942 duration_in_ms=49.599
2017-09-12 12:21:38,089 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:21:38.089329
2017-09-12 12:21:38,090 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-12 12:21:38,090 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-12 12:21:38,138 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:38,139 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:21:38.138587 duration_in_ms=49.258
2017-09-12 12:21:38,139 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 12:21:38.138970
2017-09-12 12:21:38,139 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-12 12:21:38,140 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-12 12:21:38,189 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:38,189 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 12:21:38.189116 duration_in_ms=50.146
2017-09-12 12:21:38,190 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:21:38.189528
2017-09-12 12:21:38,190 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-12 12:21:38,190 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-12 12:21:38,237 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:38,237 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:21:38.237334 duration_in_ms=47.806
2017-09-12 12:21:38,238 [salt.state       ][INFO    ][31921] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 12:21:38.237738
2017-09-12 12:21:38,238 [salt.state       ][INFO    ][31921] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-12 12:21:38,238 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-12 12:21:38,284 [salt.state       ][INFO    ][31921] unless execution succeeded
2017-09-12 12:21:38,285 [salt.state       ][INFO    ][31921] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 12:21:38.284619 duration_in_ms=46.881
2017-09-12 12:21:38,285 [salt.state       ][INFO    ][31921] Running state [keystone-credential-keys] at time 12:21:38.285422
2017-09-12 12:21:38,286 [salt.state       ][INFO    ][31921] Executing state glusterfs.started for keystone-credential-keys
2017-09-12 12:21:38,286 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:38,294 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:38,341 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --version' in directory '/root'
2017-09-12 12:21:38,349 [salt.loaded.int.module.cmdmod][INFO    ][31921] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-12 12:21:38,400 [salt.state       ][INFO    ][31921] Volume keystone-credential-keys is already started
2017-09-12 12:21:38,400 [salt.state       ][INFO    ][31921] Completed state [keystone-credential-keys] at time 12:21:38.400399 duration_in_ms=114.975
2017-09-12 12:21:38,402 [salt.minion      ][INFO    ][31921] Returning information for job: 20170912122135219983
2017-09-12 12:21:39,578 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command test.ping with jid 20170912122139570772
2017-09-12 12:21:39,592 [salt.minion      ][INFO    ][32243] Starting a new job with PID 32243
2017-09-12 12:21:39,618 [salt.minion      ][INFO    ][32243] Returning information for job: 20170912122139570772
2017-09-12 12:21:40,262 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command cmd.run with jid 20170912122140252977
2017-09-12 12:21:40,277 [salt.minion      ][INFO    ][32248] Starting a new job with PID 32248
2017-09-12 12:21:40,281 [salt.loaded.int.module.cmdmod][INFO    ][32248] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-12 12:21:40,387 [salt.minion      ][INFO    ][32248] Returning information for job: 20170912122140252977
2017-09-12 12:58:08,135 [salt.utils.schedule][INFO    ][24830] Running scheduled job: __mine_interval
2017-09-12 13:25:51,664 [salt.minion      ][INFO    ][24830] User sudo_ubuntu Executing command cp.push_dir with jid 20170912132551652616
2017-09-12 13:25:51,681 [salt.minion      ][INFO    ][703] Starting a new job with PID 703
