2017-09-19 20:38:22,196 [salt.cli.daemons ][WARNING ][2479] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-19 21:19:29,513 [salt.state       ][ERROR   ][3828] No contents found in top file
2017-09-19 21:19:47,604 [salt.utils.parsers][WARNING ][2479] Minion received a SIGTERM. Exiting.
2017-09-19 21:22:01,897 [salt.cli.daemons ][WARNING ][3234] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-19 21:25:11,529 [py.warnings      ][WARNING ][15293] /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-19 21:26:18,415 [salt.loaded.int.module.cmdmod][ERROR   ][15293] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-19 21:26:18,415 [salt.loaded.int.module.cmdmod][ERROR   ][15293] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-19 21:26:24,875 [salt.loaded.int.module.cmdmod][ERROR   ][15293] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-19 21:26:24,875 [salt.loaded.int.module.cmdmod][ERROR   ][15293] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-19 21:26:32,560 [salt.loaded.int.module.cmdmod][ERROR   ][15293] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-19 21:26:32,560 [salt.loaded.int.module.cmdmod][ERROR   ][15293] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-19 21:26:45,265 [salt.loaded.int.module.cmdmod][ERROR   ][15293] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-19 21:26:45,265 [salt.loaded.int.module.cmdmod][ERROR   ][15293] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-19 21:26:53,303 [salt.loaded.int.module.cmdmod][ERROR   ][15293] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-19 21:26:53,303 [salt.loaded.int.module.cmdmod][ERROR   ][15293] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-19 21:26:59,612 [salt.loaded.int.module.cmdmod][ERROR   ][15293] 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-19 21:27:02,898 [salt.state       ][ERROR   ][22849] No contents found in top file
2017-09-19 21:27:10,055 [py.warnings      ][WARNING ][23285] /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-19 21:27:15,243 [salt.loaded.int.module.cmdmod][INFO    ][23618] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-19 21:27:15,250 [salt.loaded.int.module.cmdmod][INFO    ][23618] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-19 21:27:15,258 [salt.loaded.int.module.cmdmod][INFO    ][23618] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-19 21:27:15,265 [salt.utils.parsers][WARNING ][3234] Minion received a SIGTERM. Exiting.
2017-09-19 21:27:15,527 [salt.cli.daemons ][INFO    ][23694] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-ha.local"
2017-09-19 21:27:16,036 [salt.minion      ][INFO    ][23694] Creating minion process manager
2017-09-19 21:27:16,037 [salt.cli.daemons ][WARNING ][23694] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-19 21:27:16,037 [salt.cli.daemons ][INFO    ][23694] The Salt Minion is starting up
2017-09-19 21:27:16,037 [salt.minion      ][INFO    ][23694] Minion is starting as user 'root'
2017-09-19 21:27:16,037 [salt.utils.event ][INFO    ][23694] Starting pull socket on /var/run/salt/minion/minion_event_a1b2f32648_pull.ipc
2017-09-19 21:27:16,817 [salt.loaded.int.module.cmdmod][INFO    ][23694] Executing command ['date', '+%z'] in directory '/root'
2017-09-19 21:27:16,839 [salt.utils.schedule][INFO    ][23694] Updating job settings for scheduled job: __mine_interval
2017-09-19 21:27:16,848 [salt.minion      ][INFO    ][23694] Added mine.update to scheduler
2017-09-19 21:27:16,936 [salt.minion      ][INFO    ][23694] Minion is ready to receive requests!
2017-09-19 21:27:17,937 [salt.utils.schedule][INFO    ][23694] Running scheduled job: __mine_interval
2017-09-19 21:28:36,136 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170919212836143717
2017-09-19 21:28:36,155 [salt.minion      ][INFO    ][23812] Starting a new job with PID 23812
2017-09-19 21:28:40,208 [salt.state       ][INFO    ][23812] Loading fresh modules for state activity
2017-09-19 21:28:40,647 [salt.state       ][ERROR   ][23812] No contents found in top file
2017-09-19 21:28:40,648 [salt.utils.extmods][INFO    ][23812] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-19 21:28:40,651 [salt.utils.extmods][INFO    ][23812] Syncing beacons for environment 'base'
2017-09-19 21:28:40,651 [salt.utils.extmods][INFO    ][23812] Loading cache from salt://_beacons, for base)
2017-09-19 21:28:40,651 [salt.fileclient  ][INFO    ][23812] Caching directory '_beacons/' for environment 'base'
2017-09-19 21:28:40,713 [salt.utils.extmods][INFO    ][23812] Syncing modules for environment 'base'
2017-09-19 21:28:40,713 [salt.utils.extmods][INFO    ][23812] Loading cache from salt://_modules, for base)
2017-09-19 21:28:40,713 [salt.fileclient  ][INFO    ][23812] Caching directory '_modules/' for environment 'base'
2017-09-19 21:28:40,749 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-19 21:28:40,757 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-19 21:28:40,984 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-19 21:28:40,999 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-19 21:28:41,022 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-19 21:28:41,036 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-19 21:28:41,054 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-19 21:28:41,067 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-19 21:28:41,079 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-19 21:28:41,092 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-19 21:28:41,117 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-19 21:28:41,132 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-19 21:28:41,209 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-19 21:28:41,242 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-19 21:28:41,252 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-19 21:28:41,264 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-19 21:28:41,278 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-19 21:28:41,290 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-19 21:28:41,299 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-19 21:28:41,309 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-19 21:28:41,498 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-19 21:28:41,525 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-19 21:28:41,549 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-19 21:28:41,563 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-19 21:28:41,569 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-19 21:28:41,606 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-19 21:28:41,647 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-19 21:28:41,746 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-19 21:28:41,766 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-19 21:28:41,776 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-19 21:28:41,789 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-19 21:28:41,810 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-19 21:28:41,814 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-19 21:28:41,814 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-19 21:28:41,815 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-19 21:28:41,815 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-19 21:28:41,815 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-19 21:28:41,816 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-19 21:28:41,816 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-19 21:28:41,816 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-19 21:28:41,816 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-19 21:28:41,817 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-19 21:28:41,817 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-19 21:28:41,817 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-19 21:28:41,817 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-19 21:28:41,817 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-19 21:28:41,818 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-19 21:28:41,818 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-19 21:28:41,818 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-19 21:28:41,818 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-19 21:28:41,819 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-19 21:28:41,819 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-19 21:28:41,819 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-19 21:28:41,820 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-19 21:28:41,820 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-19 21:28:41,821 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-19 21:28:41,821 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-19 21:28:41,821 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-19 21:28:41,821 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-19 21:28:41,822 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-19 21:28:41,822 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-19 21:28:41,822 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-19 21:28:41,822 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-19 21:28:41,822 [salt.utils.extmods][INFO    ][23812] 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-19 21:28:41,823 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-19 21:28:41,823 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-19 21:28:41,828 [salt.utils.extmods][INFO    ][23812] Syncing states for environment 'base'
2017-09-19 21:28:41,828 [salt.utils.extmods][INFO    ][23812] Loading cache from salt://_states, for base)
2017-09-19 21:28:41,828 [salt.fileclient  ][INFO    ][23812] Caching directory '_states/' for environment 'base'
2017-09-19 21:28:42,045 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-19 21:28:42,085 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-19 21:28:42,096 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-19 21:28:42,116 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-19 21:28:42,146 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-19 21:28:42,164 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-19 21:28:42,236 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-19 21:28:42,258 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-19 21:28:42,266 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-19 21:28:42,275 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-19 21:28:42,292 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-19 21:28:42,314 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-19 21:28:42,361 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-19 21:28:42,373 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-19 21:28:42,400 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-19 21:28:42,420 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-19 21:28:42,434 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-19 21:28:42,453 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-19 21:28:42,463 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-19 21:28:42,471 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-19 21:28:42,495 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-19 21:28:42,515 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-19 21:28:42,526 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-19 21:28:42,586 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-19 21:28:42,601 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-19 21:28:42,608 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-19 21:28:42,620 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-19 21:28:42,680 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-19 21:28:42,688 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-19 21:28:42,691 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-19 21:28:42,692 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-19 21:28:42,692 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-19 21:28:42,692 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-19 21:28:42,692 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-19 21:28:42,693 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-19 21:28:42,693 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-19 21:28:42,693 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-19 21:28:42,693 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-19 21:28:42,693 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-19 21:28:42,694 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-19 21:28:42,694 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-19 21:28:42,694 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-19 21:28:42,694 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-19 21:28:42,694 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-19 21:28:42,694 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-19 21:28:42,695 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-19 21:28:42,695 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-19 21:28:42,695 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-19 21:28:42,695 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-19 21:28:42,695 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-19 21:28:42,696 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-19 21:28:42,696 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-19 21:28:42,696 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-19 21:28:42,696 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-19 21:28:42,696 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-19 21:28:42,697 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-19 21:28:42,697 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-19 21:28:42,697 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-19 21:28:42,697 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-19 21:28:42,699 [salt.utils.extmods][INFO    ][23812] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-19 21:28:42,701 [salt.utils.extmods][INFO    ][23812] Syncing sdb for environment 'base'
2017-09-19 21:28:42,701 [salt.utils.extmods][INFO    ][23812] Loading cache from salt://_sdb, for base)
2017-09-19 21:28:42,702 [salt.fileclient  ][INFO    ][23812] Caching directory '_sdb/' for environment 'base'
2017-09-19 21:28:42,784 [salt.utils.extmods][INFO    ][23812] Syncing grains for environment 'base'
2017-09-19 21:28:42,784 [salt.utils.extmods][INFO    ][23812] Loading cache from salt://_grains, for base)
2017-09-19 21:28:42,784 [salt.fileclient  ][INFO    ][23812] Caching directory '_grains/' for environment 'base'
2017-09-19 21:28:42,899 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-19 21:28:42,948 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-19 21:28:43,007 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-19 21:28:43,036 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-19 21:28:43,045 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-19 21:28:43,088 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-19 21:28:43,098 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-19 21:28:43,158 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-19 21:28:43,174 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-19 21:28:43,192 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-19 21:28:43,209 [salt.fileclient  ][INFO    ][23812] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-19 21:28:43,212 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-19 21:28:43,212 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-19 21:28:43,213 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-19 21:28:43,213 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-19 21:28:43,213 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-19 21:28:43,213 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-19 21:28:43,214 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-19 21:28:43,214 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-19 21:28:43,214 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-19 21:28:43,214 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-19 21:28:43,215 [salt.utils.extmods][INFO    ][23812] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-19 21:28:43,216 [salt.utils.extmods][INFO    ][23812] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-19 21:28:43,218 [salt.utils.extmods][INFO    ][23812] Syncing renderers for environment 'base'
2017-09-19 21:28:43,219 [salt.utils.extmods][INFO    ][23812] Loading cache from salt://_renderers, for base)
2017-09-19 21:28:43,219 [salt.fileclient  ][INFO    ][23812] Caching directory '_renderers/' for environment 'base'
2017-09-19 21:28:43,298 [salt.utils.extmods][INFO    ][23812] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-19 21:28:43,300 [salt.utils.extmods][INFO    ][23812] Syncing returners for environment 'base'
2017-09-19 21:28:43,301 [salt.utils.extmods][INFO    ][23812] Loading cache from salt://_returners, for base)
2017-09-19 21:28:43,301 [salt.fileclient  ][INFO    ][23812] Caching directory '_returners/' for environment 'base'
2017-09-19 21:28:43,325 [salt.utils.extmods][INFO    ][23812] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-19 21:28:43,327 [salt.utils.extmods][INFO    ][23812] Syncing output for environment 'base'
2017-09-19 21:28:43,328 [salt.utils.extmods][INFO    ][23812] Loading cache from salt://_output, for base)
2017-09-19 21:28:43,328 [salt.fileclient  ][INFO    ][23812] Caching directory '_output/' for environment 'base'
2017-09-19 21:28:43,381 [salt.utils.extmods][INFO    ][23812] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-19 21:28:43,383 [salt.utils.extmods][INFO    ][23812] Syncing utils for environment 'base'
2017-09-19 21:28:43,383 [salt.utils.extmods][INFO    ][23812] Loading cache from salt://_utils, for base)
2017-09-19 21:28:43,384 [salt.fileclient  ][INFO    ][23812] Caching directory '_utils/' for environment 'base'
2017-09-19 21:28:43,415 [salt.utils.extmods][INFO    ][23812] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-19 21:28:43,417 [salt.utils.extmods][INFO    ][23812] Syncing log_handlers for environment 'base'
2017-09-19 21:28:43,417 [salt.utils.extmods][INFO    ][23812] Loading cache from salt://_log_handlers, for base)
2017-09-19 21:28:43,417 [salt.fileclient  ][INFO    ][23812] Caching directory '_log_handlers/' for environment 'base'
2017-09-19 21:28:43,529 [salt.utils.extmods][INFO    ][23812] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-19 21:28:43,532 [salt.utils.extmods][INFO    ][23812] Syncing proxy for environment 'base'
2017-09-19 21:28:43,532 [salt.utils.extmods][INFO    ][23812] Loading cache from salt://_proxy, for base)
2017-09-19 21:28:43,532 [salt.fileclient  ][INFO    ][23812] Caching directory '_proxy/' for environment 'base'
2017-09-19 21:28:43,612 [salt.utils.extmods][INFO    ][23812] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-19 21:28:43,614 [salt.utils.extmods][INFO    ][23812] Syncing engines for environment 'base'
2017-09-19 21:28:43,614 [salt.utils.extmods][INFO    ][23812] Loading cache from salt://_engines, for base)
2017-09-19 21:28:43,614 [salt.fileclient  ][INFO    ][23812] Caching directory '_engines/' for environment 'base'
2017-09-19 21:28:43,636 [salt.minion      ][INFO    ][23812] Returning information for job: 20170919212836143717
2017-09-19 21:34:16,982 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command test.ping with jid 20170919213416962206
2017-09-19 21:34:16,999 [salt.minion      ][INFO    ][23951] Starting a new job with PID 23951
2017-09-19 21:34:17,024 [salt.minion      ][INFO    ][23951] Returning information for job: 20170919213416962206
2017-09-19 21:37:32,594 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command state.sls with jid 20170919213732573263
2017-09-19 21:37:32,608 [salt.minion      ][INFO    ][24019] Starting a new job with PID 24019
2017-09-19 21:37:33,097 [salt.state       ][INFO    ][24019] Loading fresh modules for state activity
2017-09-19 21:37:33,190 [salt.fileclient  ][INFO    ][24019] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-19 21:37:33,207 [salt.fileclient  ][INFO    ][24019] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-19 21:37:33,230 [salt.fileclient  ][INFO    ][24019] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-19 21:37:33,506 [salt.state       ][INFO    ][24019] Running state [lsof] at time 21:37:33.505823
2017-09-19 21:37:33,506 [salt.state       ][INFO    ][24019] Executing state pkg.installed for lsof
2017-09-19 21:37:33,506 [salt.loaded.int.module.cmdmod][INFO    ][24019] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 21:37:33,736 [salt.state       ][INFO    ][24019] Package lsof is already installed
2017-09-19 21:37:33,736 [salt.state       ][INFO    ][24019] Completed state [lsof] at time 21:37:33.736356 duration_in_ms=230.533
2017-09-19 21:37:33,737 [salt.state       ][INFO    ][24019] Running state [keepalived] at time 21:37:33.736551
2017-09-19 21:37:33,737 [salt.state       ][INFO    ][24019] Executing state pkg.installed for keepalived
2017-09-19 21:37:33,752 [salt.loaded.int.module.cmdmod][INFO    ][24019] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-19 21:37:37,069 [salt.loaded.int.module.cmdmod][INFO    ][24019] 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-19 21:37:42,640 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919213742619479
2017-09-19 21:37:42,654 [salt.minion      ][INFO    ][25295] Starting a new job with PID 25295
2017-09-19 21:37:42,672 [salt.minion      ][INFO    ][25295] Returning information for job: 20170919213742619479
2017-09-19 21:37:45,018 [salt.loaded.int.module.cmdmod][INFO    ][24019] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 21:37:45,041 [salt.state       ][INFO    ][24019] 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-19 21:37:45,049 [salt.state       ][INFO    ][24019] Loading fresh modules for state activity
2017-09-19 21:37:45,061 [salt.state       ][INFO    ][24019] Completed state [keepalived] at time 21:37:45.060570 duration_in_ms=11324.018
2017-09-19 21:37:45,063 [salt.state       ][INFO    ][24019] Running state [/etc/keepalived/keepalived.conf] at time 21:37:45.062648
2017-09-19 21:37:45,063 [salt.state       ][INFO    ][24019] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-19 21:37:45,087 [salt.fileclient  ][INFO    ][24019] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-19 21:37:45,115 [salt.fileclient  ][INFO    ][24019] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-19 21:37:45,121 [salt.state       ][INFO    ][24019] File changed:
New file
2017-09-19 21:37:45,121 [salt.state       ][INFO    ][24019] Completed state [/etc/keepalived/keepalived.conf] at time 21:37:45.121101 duration_in_ms=58.453
2017-09-19 21:37:45,177 [salt.state       ][INFO    ][24019] Running state [keepalived] at time 21:37:45.176761
2017-09-19 21:37:45,177 [salt.state       ][INFO    ][24019] Executing state service.running for keepalived
2017-09-19 21:37:45,178 [salt.loaded.int.module.cmdmod][INFO    ][24019] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-19 21:37:45,187 [salt.loaded.int.module.cmdmod][INFO    ][24019] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-19 21:37:45,195 [salt.loaded.int.module.cmdmod][INFO    ][24019] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-19 21:37:45,202 [salt.loaded.int.module.cmdmod][INFO    ][24019] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-19 21:37:45,211 [salt.loaded.int.module.cmdmod][INFO    ][24019] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-19 21:37:45,270 [salt.loaded.int.module.cmdmod][INFO    ][24019] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-19 21:37:45,278 [salt.loaded.int.module.cmdmod][INFO    ][24019] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-19 21:37:45,287 [salt.loaded.int.module.cmdmod][INFO    ][24019] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-19 21:37:45,294 [salt.state       ][INFO    ][24019] {'keepalived': True}
2017-09-19 21:37:45,294 [salt.state       ][INFO    ][24019] Completed state [keepalived] at time 21:37:45.294380 duration_in_ms=117.619
2017-09-19 21:37:45,295 [salt.minion      ][INFO    ][24019] Returning information for job: 20170919213732573263
2017-09-19 21:38:31,735 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command pillar.get with jid 20170919213831721020
2017-09-19 21:38:31,753 [salt.minion      ][INFO    ][25588] Starting a new job with PID 25588
2017-09-19 21:38:31,763 [salt.minion      ][INFO    ][25588] Returning information for job: 20170919213831721020
2017-09-19 21:44:05,862 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command state.sls with jid 20170919214405856349
2017-09-19 21:44:05,878 [salt.minion      ][INFO    ][25690] Starting a new job with PID 25690
2017-09-19 21:44:08,325 [salt.state       ][INFO    ][25690] Loading fresh modules for state activity
2017-09-19 21:44:08,348 [salt.fileclient  ][INFO    ][25690] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-19 21:44:08,367 [salt.fileclient  ][INFO    ][25690] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-19 21:44:08,627 [salt.state       ][INFO    ][25690] Running state [attr] at time 21:44:08.626716
2017-09-19 21:44:08,627 [salt.state       ][INFO    ][25690] Executing state pkg.installed for attr
2017-09-19 21:44:08,627 [salt.loaded.int.module.cmdmod][INFO    ][25690] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 21:44:08,899 [salt.loaded.int.module.cmdmod][INFO    ][25690] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-19 21:44:10,887 [salt.loaded.int.module.cmdmod][INFO    ][25690] 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-19 21:44:13,280 [salt.loaded.int.module.cmdmod][INFO    ][25690] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 21:44:13,305 [salt.state       ][INFO    ][25690] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-19 21:44:13,313 [salt.state       ][INFO    ][25690] Loading fresh modules for state activity
2017-09-19 21:44:13,325 [salt.state       ][INFO    ][25690] Completed state [attr] at time 21:44:13.324571 duration_in_ms=4697.855
2017-09-19 21:44:13,329 [salt.state       ][INFO    ][25690] Running state [glusterfs-server] at time 21:44:13.329247
2017-09-19 21:44:13,329 [salt.state       ][INFO    ][25690] Executing state pkg.installed for glusterfs-server
2017-09-19 21:44:13,513 [salt.loaded.int.module.cmdmod][INFO    ][25690] 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-19 21:44:15,955 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919214415943547
2017-09-19 21:44:15,971 [salt.minion      ][INFO    ][26689] Starting a new job with PID 26689
2017-09-19 21:44:15,980 [salt.minion      ][INFO    ][26689] Returning information for job: 20170919214415943547
2017-09-19 21:44:26,167 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919214426157399
2017-09-19 21:44:26,183 [salt.minion      ][INFO    ][29531] Starting a new job with PID 29531
2017-09-19 21:44:26,192 [salt.minion      ][INFO    ][29531] Returning information for job: 20170919214426157399
2017-09-19 21:44:30,026 [salt.loaded.int.module.cmdmod][INFO    ][25690] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 21:44:30,053 [salt.state       ][INFO    ][25690] 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-19 21:44:30,060 [salt.state       ][INFO    ][25690] Loading fresh modules for state activity
2017-09-19 21:44:30,072 [salt.state       ][INFO    ][25690] Completed state [glusterfs-server] at time 21:44:30.072010 duration_in_ms=16742.762
2017-09-19 21:44:30,079 [salt.state       ][INFO    ][25690] Running state [bc] at time 21:44:30.078487
2017-09-19 21:44:30,079 [salt.state       ][INFO    ][25690] Executing state pkg.installed for bc
2017-09-19 21:44:30,359 [salt.loaded.int.module.cmdmod][INFO    ][25690] 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-19 21:44:33,284 [salt.loaded.int.module.cmdmod][INFO    ][25690] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 21:44:33,309 [salt.state       ][INFO    ][25690] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-19 21:44:33,316 [salt.state       ][INFO    ][25690] Loading fresh modules for state activity
2017-09-19 21:44:33,328 [salt.state       ][INFO    ][25690] Completed state [bc] at time 21:44:33.328296 duration_in_ms=3249.808
2017-09-19 21:44:33,395 [salt.state       ][INFO    ][25690] Running state [glusterfs-server] at time 21:44:33.395291
2017-09-19 21:44:33,396 [salt.state       ][INFO    ][25690] Executing state service.running for glusterfs-server
2017-09-19 21:44:33,397 [salt.loaded.int.module.cmdmod][INFO    ][25690] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-19 21:44:33,407 [salt.loaded.int.module.cmdmod][INFO    ][25690] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-19 21:44:33,414 [salt.loaded.int.module.cmdmod][INFO    ][25690] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-19 21:44:33,423 [salt.state       ][INFO    ][25690] The service glusterfs-server is already running
2017-09-19 21:44:33,423 [salt.state       ][INFO    ][25690] Completed state [glusterfs-server] at time 21:44:33.423248 duration_in_ms=27.957
2017-09-19 21:44:33,425 [salt.state       ][INFO    ][25690] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:44:33.424633
2017-09-19 21:44:33,425 [salt.state       ][INFO    ][25690] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-19 21:44:33,441 [salt.state       ][INFO    ][25690] File changed:
New file
2017-09-19 21:44:33,441 [salt.state       ][INFO    ][25690] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:44:33.441171 duration_in_ms=16.536
2017-09-19 21:44:33,441 [salt.state       ][INFO    ][25690] Running state [/srv/glusterfs/glance] at time 21:44:33.441396
2017-09-19 21:44:33,442 [salt.state       ][INFO    ][25690] Executing state file.directory for /srv/glusterfs/glance
2017-09-19 21:44:33,442 [salt.state       ][INFO    ][25690] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-19 21:44:33,442 [salt.state       ][INFO    ][25690] Completed state [/srv/glusterfs/glance] at time 21:44:33.442332 duration_in_ms=0.935
2017-09-19 21:44:33,443 [salt.state       ][INFO    ][25690] Running state [/srv/glusterfs/keystone-keys] at time 21:44:33.442481
2017-09-19 21:44:33,443 [salt.state       ][INFO    ][25690] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-19 21:44:33,443 [salt.state       ][INFO    ][25690] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-19 21:44:33,443 [salt.state       ][INFO    ][25690] Completed state [/srv/glusterfs/keystone-keys] at time 21:44:33.443128 duration_in_ms=0.648
2017-09-19 21:44:33,443 [salt.state       ][INFO    ][25690] Running state [/srv/glusterfs/nova_instances] at time 21:44:33.443275
2017-09-19 21:44:33,443 [salt.state       ][INFO    ][25690] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-19 21:44:33,444 [salt.state       ][INFO    ][25690] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-19 21:44:33,444 [salt.state       ][INFO    ][25690] Completed state [/srv/glusterfs/nova_instances] at time 21:44:33.443959 duration_in_ms=0.684
2017-09-19 21:44:33,444 [salt.state       ][INFO    ][25690] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:44:33.444106
2017-09-19 21:44:33,444 [salt.state       ][INFO    ][25690] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-19 21:44:33,445 [salt.state       ][INFO    ][25690] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-19 21:44:33,445 [salt.state       ][INFO    ][25690] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:44:33.444740 duration_in_ms=0.634
2017-09-19 21:44:33,445 [salt.minion      ][INFO    ][25690] Returning information for job: 20170919214405856349
2017-09-19 21:44:41,986 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command test.ping with jid 20170919214441980542
2017-09-19 21:44:42,002 [salt.minion      ][INFO    ][30397] Starting a new job with PID 30397
2017-09-19 21:44:42,028 [salt.minion      ][INFO    ][30397] Returning information for job: 20170919214441980542
2017-09-19 21:44:42,192 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command state.sls with jid 20170919214442182614
2017-09-19 21:44:42,207 [salt.minion      ][INFO    ][30402] Starting a new job with PID 30402
2017-09-19 21:44:43,724 [salt.state       ][INFO    ][30402] Loading fresh modules for state activity
2017-09-19 21:44:43,745 [salt.fileclient  ][INFO    ][30402] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-19 21:44:43,778 [salt.fileclient  ][INFO    ][30402] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-19 21:44:43,840 [salt.fileclient  ][INFO    ][30402] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-19 21:44:43,860 [salt.fileclient  ][INFO    ][30402] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-19 21:44:44,114 [salt.state       ][INFO    ][30402] Running state [attr] at time 21:44:44.113588
2017-09-19 21:44:44,114 [salt.state       ][INFO    ][30402] Executing state pkg.installed for attr
2017-09-19 21:44:44,114 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-19 21:44:44,348 [salt.state       ][INFO    ][30402] Package attr is already installed
2017-09-19 21:44:44,348 [salt.state       ][INFO    ][30402] Completed state [attr] at time 21:44:44.348072 duration_in_ms=234.484
2017-09-19 21:44:44,348 [salt.state       ][INFO    ][30402] Running state [glusterfs-server] at time 21:44:44.348283
2017-09-19 21:44:44,348 [salt.state       ][INFO    ][30402] Executing state pkg.installed for glusterfs-server
2017-09-19 21:44:44,351 [salt.state       ][INFO    ][30402] Package glusterfs-server is already installed
2017-09-19 21:44:44,351 [salt.state       ][INFO    ][30402] Completed state [glusterfs-server] at time 21:44:44.351185 duration_in_ms=2.901
2017-09-19 21:44:44,351 [salt.state       ][INFO    ][30402] Running state [bc] at time 21:44:44.351324
2017-09-19 21:44:44,351 [salt.state       ][INFO    ][30402] Executing state pkg.installed for bc
2017-09-19 21:44:44,354 [salt.state       ][INFO    ][30402] Package bc is already installed
2017-09-19 21:44:44,354 [salt.state       ][INFO    ][30402] Completed state [bc] at time 21:44:44.354087 duration_in_ms=2.763
2017-09-19 21:44:44,355 [salt.state       ][INFO    ][30402] Running state [glusterfs-server] at time 21:44:44.354883
2017-09-19 21:44:44,355 [salt.state       ][INFO    ][30402] Executing state service.running for glusterfs-server
2017-09-19 21:44:44,355 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-19 21:44:44,365 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-19 21:44:44,409 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-19 21:44:44,423 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-19 21:44:44,431 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-19 21:44:44,440 [salt.state       ][INFO    ][30402] The service glusterfs-server is already running
2017-09-19 21:44:44,440 [salt.state       ][INFO    ][30402] Completed state [glusterfs-server] at time 21:44:44.440231 duration_in_ms=85.347
2017-09-19 21:44:44,442 [salt.state       ][INFO    ][30402] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:44:44.441567
2017-09-19 21:44:44,442 [salt.state       ][INFO    ][30402] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-19 21:44:44,453 [salt.state       ][INFO    ][30402] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-19 21:44:44,453 [salt.state       ][INFO    ][30402] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:44:44.452801 duration_in_ms=11.234
2017-09-19 21:44:44,453 [salt.state       ][INFO    ][30402] Running state [/srv/glusterfs/glance] at time 21:44:44.452945
2017-09-19 21:44:44,453 [salt.state       ][INFO    ][30402] Executing state file.directory for /srv/glusterfs/glance
2017-09-19 21:44:44,453 [salt.state       ][INFO    ][30402] Directory /srv/glusterfs/glance is in the correct state
2017-09-19 21:44:44,454 [salt.state       ][INFO    ][30402] Completed state [/srv/glusterfs/glance] at time 21:44:44.453496 duration_in_ms=0.551
2017-09-19 21:44:44,454 [salt.state       ][INFO    ][30402] Running state [/srv/glusterfs/keystone-keys] at time 21:44:44.453631
2017-09-19 21:44:44,454 [salt.state       ][INFO    ][30402] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-19 21:44:44,454 [salt.state       ][INFO    ][30402] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-19 21:44:44,454 [salt.state       ][INFO    ][30402] Completed state [/srv/glusterfs/keystone-keys] at time 21:44:44.454186 duration_in_ms=0.554
2017-09-19 21:44:44,454 [salt.state       ][INFO    ][30402] Running state [/srv/glusterfs/nova_instances] at time 21:44:44.454327
2017-09-19 21:44:44,454 [salt.state       ][INFO    ][30402] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-19 21:44:44,455 [salt.state       ][INFO    ][30402] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-19 21:44:44,455 [salt.state       ][INFO    ][30402] Completed state [/srv/glusterfs/nova_instances] at time 21:44:44.454898 duration_in_ms=0.571
2017-09-19 21:44:44,455 [salt.state       ][INFO    ][30402] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:44:44.455038
2017-09-19 21:44:44,455 [salt.state       ][INFO    ][30402] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-19 21:44:44,455 [salt.state       ][INFO    ][30402] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-19 21:44:44,456 [salt.state       ][INFO    ][30402] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:44:44.455579 duration_in_ms=0.54
2017-09-19 21:44:44,509 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command ['git', '--version'] in directory '/root'
2017-09-19 21:44:44,552 [salt.state       ][INFO    ][30402] Running state [sleep 5] at time 21:44:44.551909
2017-09-19 21:44:44,552 [salt.state       ][INFO    ][30402] Executing state cmd.wait for sleep 5
2017-09-19 21:44:44,552 [salt.state       ][INFO    ][30402] No changes made for sleep 5
2017-09-19 21:44:44,553 [salt.state       ][INFO    ][30402] Completed state [sleep 5] at time 21:44:44.552486 duration_in_ms=0.578
2017-09-19 21:44:44,553 [salt.state       ][INFO    ][30402] Running state [10.167.4.141] at time 21:44:44.552910
2017-09-19 21:44:44,553 [salt.state       ][INFO    ][30402] Executing state glusterfs.peered for 10.167.4.141
2017-09-19 21:44:44,553 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:44,563 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:44,616 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:44,626 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:44,967 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:44,978 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:45,037 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:45,049 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:45,102 [salt.state       ][INFO    ][30402] {'new': {'10.167.4.141': []}, 'old': None}
2017-09-19 21:44:45,102 [salt.state       ][INFO    ][30402] Completed state [10.167.4.141] at time 21:44:45.102264 duration_in_ms=549.353
2017-09-19 21:44:45,105 [salt.state       ][INFO    ][30402] Running state [10.167.4.142] at time 21:44:45.104650
2017-09-19 21:44:45,105 [salt.state       ][INFO    ][30402] Executing state glusterfs.peered for 10.167.4.142
2017-09-19 21:44:45,105 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:45,115 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:45,256 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:45,266 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:45,322 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:45,386 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:45,438 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:45,447 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:45,495 [salt.state       ][INFO    ][30402] Peering with localhost is not needed
2017-09-19 21:44:45,495 [salt.state       ][INFO    ][30402] Completed state [10.167.4.142] at time 21:44:45.495459 duration_in_ms=390.809
2017-09-19 21:44:45,498 [salt.state       ][INFO    ][30402] Running state [10.167.4.143] at time 21:44:45.497698
2017-09-19 21:44:45,498 [salt.state       ][INFO    ][30402] Executing state glusterfs.peered for 10.167.4.143
2017-09-19 21:44:45,498 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:45,508 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:45,559 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:45,568 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:45,874 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:45,886 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:45,945 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:45,954 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:46,017 [salt.state       ][INFO    ][30402] {'new': {'10.167.4.141': [], '10.167.4.143': []}, 'old': {'10.167.4.141': []}}
2017-09-19 21:44:46,018 [salt.state       ][INFO    ][30402] Completed state [10.167.4.143] at time 21:44:46.017778 duration_in_ms=520.079
2017-09-19 21:44:46,019 [salt.state       ][INFO    ][30402] Running state [glance] at time 21:44:46.018703
2017-09-19 21:44:46,019 [salt.state       ][INFO    ][30402] Executing state glusterfs.created for glance
2017-09-19 21:44:46,020 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:46,030 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:46,156 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:46,167 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:47,172 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:47,184 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:48,305 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:48,317 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:48,370 [salt.state       ][INFO    ][30402] {'new': ['glance'], 'old': []}
2017-09-19 21:44:48,370 [salt.state       ][INFO    ][30402] Completed state [glance] at time 21:44:48.370381 duration_in_ms=2351.678
2017-09-19 21:44:48,373 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:44:48.373208
2017-09-19 21:44:48,373 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-19 21:44:48,374 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-19 21:44:48,425 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-09-19 21:44:49,119 [salt.state       ][INFO    ][30402] {'pid': 30625, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:44:49,119 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:44:49.119404 duration_in_ms=746.194
2017-09-19 21:44:49,120 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:44:49.119969
2017-09-19 21:44:49,120 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-19 21:44:49,121 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-19 21:44:49,175 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-09-19 21:44:49,837 [salt.state       ][INFO    ][30402] {'pid': 30644, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:44:49,837 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:44:49.837036 duration_in_ms=717.066
2017-09-19 21:44:49,838 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:44:49.837586
2017-09-19 21:44:49,838 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-19 21:44:49,838 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-19 21:44:49,895 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-09-19 21:44:52,235 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919214452223483
2017-09-19 21:44:52,250 [salt.minion      ][INFO    ][30672] Starting a new job with PID 30672
2017-09-19 21:44:52,259 [salt.minion      ][INFO    ][30672] Returning information for job: 20170919214452223483
2017-09-19 21:44:52,578 [salt.state       ][INFO    ][30402] {'pid': 30662, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:44:52,579 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:44:52.578493 duration_in_ms=2740.906
2017-09-19 21:44:52,579 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:44:52.579083
2017-09-19 21:44:52,579 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-19 21:44:52,580 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-19 21:44:52,637 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-09-19 21:44:53,345 [salt.state       ][INFO    ][30402] {'pid': 30687, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:44:53,346 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:44:53.345783 duration_in_ms=766.699
2017-09-19 21:44:53,346 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:44:53.346337
2017-09-19 21:44:53,347 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-19 21:44:53,347 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-19 21:44:53,403 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-09-19 21:44:54,077 [salt.state       ][INFO    ][30402] {'pid': 30704, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:44:54,077 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:44:54.077073 duration_in_ms=730.735
2017-09-19 21:44:54,078 [salt.state       ][INFO    ][30402] Running state [glance] at time 21:44:54.078121
2017-09-19 21:44:54,078 [salt.state       ][INFO    ][30402] Executing state glusterfs.started for glance
2017-09-19 21:44:54,079 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:54,090 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:54,143 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:54,153 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:54,209 [salt.state       ][INFO    ][30402] Volume glance is already started
2017-09-19 21:44:54,209 [salt.state       ][INFO    ][30402] Completed state [glance] at time 21:44:54.209369 duration_in_ms=131.247
2017-09-19 21:44:54,210 [salt.state       ][INFO    ][30402] Running state [keystone-keys] at time 21:44:54.210209
2017-09-19 21:44:54,210 [salt.state       ][INFO    ][30402] Executing state glusterfs.created for keystone-keys
2017-09-19 21:44:54,211 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:54,220 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:54,270 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:54,279 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:54,982 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:54,994 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:57,901 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:44:57,912 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:44:57,963 [salt.state       ][INFO    ][30402] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-09-19 21:44:57,963 [salt.state       ][INFO    ][30402] Completed state [keystone-keys] at time 21:44:57.963176 duration_in_ms=3752.967
2017-09-19 21:44:57,966 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:44:57.966041
2017-09-19 21:44:57,966 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-19 21:44:57,967 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-19 21:44:58,019 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-09-19 21:44:58,690 [salt.state       ][INFO    ][30402] {'pid': 30815, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:44:58,690 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:44:58.690199 duration_in_ms=724.157
2017-09-19 21:44:58,691 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:44:58.690774
2017-09-19 21:44:58,691 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-19 21:44:58,692 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-19 21:44:58,749 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-09-19 21:44:59,590 [salt.state       ][INFO    ][30402] {'pid': 30832, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:44:59,591 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:44:59.590795 duration_in_ms=900.02
2017-09-19 21:44:59,592 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:44:59.591626
2017-09-19 21:44:59,592 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-19 21:44:59,593 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-19 21:44:59,651 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-09-19 21:45:00,333 [salt.state       ][INFO    ][30402] {'pid': 30850, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:45:00,333 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:45:00.332841 duration_in_ms=741.214
2017-09-19 21:45:00,333 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:45:00.333421
2017-09-19 21:45:00,334 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-19 21:45:00,334 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-19 21:45:00,392 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-09-19 21:45:02,377 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919214502364668
2017-09-19 21:45:02,393 [salt.minion      ][INFO    ][30880] Starting a new job with PID 30880
2017-09-19 21:45:02,403 [salt.minion      ][INFO    ][30880] Returning information for job: 20170919214502364668
2017-09-19 21:45:03,101 [salt.state       ][INFO    ][30402] {'pid': 30867, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:45:03,102 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:45:03.101780 duration_in_ms=2768.357
2017-09-19 21:45:03,102 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:45:03.102391
2017-09-19 21:45:03,103 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-19 21:45:03,103 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-19 21:45:03,162 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-09-19 21:45:03,772 [salt.state       ][INFO    ][30402] {'pid': 30892, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:45:03,773 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:45:03.772599 duration_in_ms=670.207
2017-09-19 21:45:03,774 [salt.state       ][INFO    ][30402] Running state [keystone-keys] at time 21:45:03.773691
2017-09-19 21:45:03,774 [salt.state       ][INFO    ][30402] Executing state glusterfs.started for keystone-keys
2017-09-19 21:45:03,775 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:03,787 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:03,841 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:03,851 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:03,909 [salt.state       ][INFO    ][30402] Volume keystone-keys is already started
2017-09-19 21:45:03,910 [salt.state       ][INFO    ][30402] Completed state [keystone-keys] at time 21:45:03.909641 duration_in_ms=135.948
2017-09-19 21:45:03,911 [salt.state       ][INFO    ][30402] Running state [nova_instances] at time 21:45:03.910594
2017-09-19 21:45:03,911 [salt.state       ][INFO    ][30402] Executing state glusterfs.created for nova_instances
2017-09-19 21:45:03,911 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:03,922 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:03,976 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:03,986 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:04,925 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:04,937 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:08,166 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:08,178 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:08,232 [salt.state       ][INFO    ][30402] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-09-19 21:45:08,232 [salt.state       ][INFO    ][30402] Completed state [nova_instances] at time 21:45:08.231799 duration_in_ms=4321.204
2017-09-19 21:45:08,236 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:45:08.235904
2017-09-19 21:45:08,236 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-19 21:45:08,237 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-19 21:45:08,289 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-09-19 21:45:08,908 [salt.state       ][INFO    ][30402] {'pid': 31006, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:45:08,908 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:45:08.907870 duration_in_ms=671.964
2017-09-19 21:45:08,908 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 21:45:08.908403
2017-09-19 21:45:08,909 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-09-19 21:45:08,909 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-19 21:45:08,965 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-09-19 21:45:09,659 [salt.state       ][INFO    ][30402] {'pid': 31024, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:45:09,659 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 21:45:09.659439 duration_in_ms=751.035
2017-09-19 21:45:09,660 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 21:45:09.659984
2017-09-19 21:45:09,660 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-09-19 21:45:09,661 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-19 21:45:09,716 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'True'' in directory '/root'
2017-09-19 21:45:10,363 [salt.state       ][INFO    ][30402] {'pid': 31041, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:45:10,363 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 21:45:10.362880 duration_in_ms=702.895
2017-09-19 21:45:10,364 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 21:45:10.363586
2017-09-19 21:45:10,364 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-09-19 21:45:10,365 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-09-19 21:45:10,420 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'True'' in directory '/root'
2017-09-19 21:45:12,522 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919214512510982
2017-09-19 21:45:12,538 [salt.minion      ][INFO    ][31072] Starting a new job with PID 31072
2017-09-19 21:45:12,548 [salt.minion      ][INFO    ][31072] Returning information for job: 20170919214512510982
2017-09-19 21:45:13,105 [salt.state       ][INFO    ][30402] {'pid': 31059, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:45:13,106 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 21:45:13.105613 duration_in_ms=2742.027
2017-09-19 21:45:13,106 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:45:13.106213
2017-09-19 21:45:13,107 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-19 21:45:13,107 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-19 21:45:13,164 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-09-19 21:45:13,824 [salt.state       ][INFO    ][30402] {'pid': 31084, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:45:13,824 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:45:13.824080 duration_in_ms=717.866
2017-09-19 21:45:13,825 [salt.state       ][INFO    ][30402] Running state [nova_instances] at time 21:45:13.825097
2017-09-19 21:45:13,825 [salt.state       ][INFO    ][30402] Executing state glusterfs.started for nova_instances
2017-09-19 21:45:13,826 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:13,838 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:13,891 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:13,901 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:13,957 [salt.state       ][INFO    ][30402] Volume nova_instances is already started
2017-09-19 21:45:13,958 [salt.state       ][INFO    ][30402] Completed state [nova_instances] at time 21:45:13.957609 duration_in_ms=132.511
2017-09-19 21:45:13,959 [salt.state       ][INFO    ][30402] Running state [keystone-credential-keys] at time 21:45:13.958487
2017-09-19 21:45:13,959 [salt.state       ][INFO    ][30402] Executing state glusterfs.created for keystone-credential-keys
2017-09-19 21:45:13,959 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:13,968 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:14,019 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:14,029 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:14,737 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:14,749 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:17,642 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:17,654 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:17,708 [salt.state       ][INFO    ][30402] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-09-19 21:45:17,708 [salt.state       ][INFO    ][30402] Completed state [keystone-credential-keys] at time 21:45:17.708145 duration_in_ms=3749.657
2017-09-19 21:45:17,711 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:45:17.711268
2017-09-19 21:45:17,712 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-19 21:45:17,712 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-19 21:45:17,766 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-09-19 21:45:18,437 [salt.state       ][INFO    ][30402] {'pid': 31202, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:45:18,437 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:45:18.437043 duration_in_ms=725.775
2017-09-19 21:45:18,438 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:45:18.437591
2017-09-19 21:45:18,438 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-19 21:45:18,438 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-19 21:45:18,497 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-09-19 21:45:19,142 [salt.state       ][INFO    ][30402] {'pid': 31219, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:45:19,142 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:45:19.142145 duration_in_ms=704.554
2017-09-19 21:45:19,143 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:45:19.142818
2017-09-19 21:45:19,143 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-19 21:45:19,144 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-19 21:45:19,201 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-09-19 21:45:22,019 [salt.state       ][INFO    ][30402] {'pid': 31237, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:45:22,020 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:45:22.019627 duration_in_ms=2876.808
2017-09-19 21:45:22,020 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:45:22.020179
2017-09-19 21:45:22,020 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-19 21:45:22,021 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-19 21:45:22,080 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-09-19 21:45:22,665 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command saltutil.find_job with jid 20170919214522654628
2017-09-19 21:45:22,680 [salt.minion      ][INFO    ][31270] Starting a new job with PID 31270
2017-09-19 21:45:22,689 [salt.minion      ][INFO    ][31270] Returning information for job: 20170919214522654628
2017-09-19 21:45:22,780 [salt.state       ][INFO    ][30402] {'pid': 31259, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:45:22,780 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:45:22.780072 duration_in_ms=759.892
2017-09-19 21:45:22,781 [salt.state       ][INFO    ][30402] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:45:22.780613
2017-09-19 21:45:22,781 [salt.state       ][INFO    ][30402] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-19 21:45:22,781 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-19 21:45:22,837 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-09-19 21:45:23,487 [salt.state       ][INFO    ][30402] {'pid': 31282, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-19 21:45:23,487 [salt.state       ][INFO    ][30402] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:45:23.487222 duration_in_ms=706.608
2017-09-19 21:45:23,488 [salt.state       ][INFO    ][30402] Running state [keystone-credential-keys] at time 21:45:23.488244
2017-09-19 21:45:23,489 [salt.state       ][INFO    ][30402] Executing state glusterfs.started for keystone-credential-keys
2017-09-19 21:45:23,489 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:23,500 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:23,555 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --version' in directory '/root'
2017-09-19 21:45:23,564 [salt.loaded.int.module.cmdmod][INFO    ][30402] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-19 21:45:23,621 [salt.state       ][INFO    ][30402] Volume keystone-credential-keys is already started
2017-09-19 21:45:23,622 [salt.state       ][INFO    ][30402] Completed state [keystone-credential-keys] at time 21:45:23.621563 duration_in_ms=133.317
2017-09-19 21:45:23,624 [salt.minion      ][INFO    ][30402] Returning information for job: 20170919214442182614
2017-09-19 21:45:36,984 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command test.ping with jid 20170919214536977613
2017-09-19 21:45:36,1000 [salt.minion      ][INFO    ][31314] Starting a new job with PID 31314
2017-09-19 21:45:37,027 [salt.minion      ][INFO    ][31314] Returning information for job: 20170919214536977613
2017-09-19 21:45:37,185 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command cmd.run with jid 20170919214537176320
2017-09-19 21:45:37,200 [salt.minion      ][INFO    ][31319] Starting a new job with PID 31319
2017-09-19 21:45:37,203 [salt.loaded.int.module.cmdmod][INFO    ][31319] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-19 21:45:37,314 [salt.minion      ][INFO    ][31319] Returning information for job: 20170919214537176320
2017-09-19 22:27:17,938 [salt.utils.schedule][INFO    ][23694] Running scheduled job: __mine_interval
2017-09-19 23:09:16,527 [salt.minion      ][INFO    ][23694] User sudo_ubuntu Executing command cp.push_dir with jid 20170919230916518677
2017-09-19 23:09:16,553 [salt.minion      ][INFO    ][32620] Starting a new job with PID 32620
