2017-09-17 02:52:00,840 [salt.cli.daemons ][WARNING ][2616] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-17 04:46:34,887 [salt.state       ][ERROR   ][4016] No contents found in top file
2017-09-17 04:46:54,246 [salt.utils.parsers][WARNING ][2616] Minion received a SIGTERM. Exiting.
2017-09-17 04:49:18,900 [salt.cli.daemons ][WARNING ][3327] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-17 04:52:20,618 [py.warnings      ][WARNING ][16379] /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-17 04:53:20,356 [salt.loaded.int.module.cmdmod][ERROR   ][16379] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-17 04:53:20,357 [salt.loaded.int.module.cmdmod][ERROR   ][16379] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-17 04:53:30,350 [salt.loaded.int.module.cmdmod][ERROR   ][16379] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-17 04:53:30,350 [salt.loaded.int.module.cmdmod][ERROR   ][16379] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-17 04:53:38,706 [salt.loaded.int.module.cmdmod][ERROR   ][16379] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-17 04:53:38,707 [salt.loaded.int.module.cmdmod][ERROR   ][16379] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-17 04:53:53,704 [salt.loaded.int.module.cmdmod][ERROR   ][16379] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-17 04:53:53,705 [salt.loaded.int.module.cmdmod][ERROR   ][16379] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-17 04:54:02,240 [salt.loaded.int.module.cmdmod][ERROR   ][16379] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-17 04:54:02,241 [salt.loaded.int.module.cmdmod][ERROR   ][16379] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-17 04:54:09,905 [salt.loaded.int.module.cmdmod][ERROR   ][16379] 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-17 04:54:13,499 [salt.state       ][ERROR   ][23973] No contents found in top file
2017-09-17 04:54:24,064 [py.warnings      ][WARNING ][24438] /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-17 04:54:24,207 [salt.loaded.int.module.cmdmod][INFO    ][24439] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-17 04:54:24,223 [salt.loaded.int.module.cmdmod][INFO    ][24439] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-17 04:54:24,260 [salt.loaded.int.module.cmdmod][INFO    ][24439] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-17 04:54:24,302 [salt.utils.parsers][WARNING ][3327] Minion received a SIGTERM. Exiting.
2017-09-17 04:54:24,739 [salt.cli.daemons ][INFO    ][24567] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-odl-ha.local"
2017-09-17 04:54:25,447 [salt.minion      ][INFO    ][24567] Creating minion process manager
2017-09-17 04:54:25,447 [salt.cli.daemons ][WARNING ][24567] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-17 04:54:25,447 [salt.cli.daemons ][INFO    ][24567] The Salt Minion is starting up
2017-09-17 04:54:25,448 [salt.minion      ][INFO    ][24567] Minion is starting as user 'root'
2017-09-17 04:54:25,448 [salt.utils.event ][INFO    ][24567] Starting pull socket on /var/run/salt/minion/minion_event_0607a05f39_pull.ipc
2017-09-17 04:54:26,460 [salt.loaded.int.module.cmdmod][INFO    ][24567] Executing command ['date', '+%z'] in directory '/root'
2017-09-17 04:54:26,474 [salt.utils.schedule][INFO    ][24567] Updating job settings for scheduled job: __mine_interval
2017-09-17 04:54:26,476 [salt.minion      ][INFO    ][24567] Added mine.update to scheduler
2017-09-17 04:54:26,549 [salt.minion      ][INFO    ][24567] Minion is ready to receive requests!
2017-09-17 04:54:27,550 [salt.utils.schedule][INFO    ][24567] Running scheduled job: __mine_interval
2017-09-17 04:54:33,011 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170917045432996093
2017-09-17 04:54:33,029 [salt.minion      ][INFO    ][24663] Starting a new job with PID 24663
2017-09-17 04:54:33,083 [salt.minion      ][INFO    ][24663] Returning information for job: 20170917045432996093
2017-09-17 04:55:37,648 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170917045537632081
2017-09-17 04:55:37,669 [salt.minion      ][INFO    ][24680] Starting a new job with PID 24680
2017-09-17 04:55:39,888 [salt.state       ][INFO    ][24680] Loading fresh modules for state activity
2017-09-17 04:55:39,928 [salt.state       ][ERROR   ][24680] No contents found in top file
2017-09-17 04:55:39,929 [salt.utils.extmods][INFO    ][24680] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-17 04:55:39,935 [salt.utils.extmods][INFO    ][24680] Syncing beacons for environment 'base'
2017-09-17 04:55:39,936 [salt.utils.extmods][INFO    ][24680] Loading cache from salt://_beacons, for base)
2017-09-17 04:55:39,936 [salt.fileclient  ][INFO    ][24680] Caching directory '_beacons/' for environment 'base'
2017-09-17 04:55:39,989 [salt.utils.extmods][INFO    ][24680] Syncing modules for environment 'base'
2017-09-17 04:55:39,990 [salt.utils.extmods][INFO    ][24680] Loading cache from salt://_modules, for base)
2017-09-17 04:55:39,990 [salt.fileclient  ][INFO    ][24680] Caching directory '_modules/' for environment 'base'
2017-09-17 04:55:40,035 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-17 04:55:40,599 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-17 04:55:41,679 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-17 04:55:41,691 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-17 04:55:41,702 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-17 04:55:41,712 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-17 04:55:41,723 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-17 04:55:41,734 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-17 04:55:41,816 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-17 04:55:41,925 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-17 04:55:41,940 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-17 04:55:41,951 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-17 04:55:41,962 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-17 04:55:41,972 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-17 04:55:41,991 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-17 04:55:42,004 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-17 04:55:42,015 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-17 04:55:42,026 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-17 04:55:42,287 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-17 04:55:42,322 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-17 04:55:42,337 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-17 04:55:42,373 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-17 04:55:42,530 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-17 04:55:42,616 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-17 04:55:42,638 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-17 04:55:42,667 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-17 04:55:42,711 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-17 04:55:42,855 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-17 04:55:42,875 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-17 04:55:42,926 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-17 04:55:43,110 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-17 04:55:43,122 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-17 04:55:43,127 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-17 04:55:43,127 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-17 04:55:43,128 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-17 04:55:43,128 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-17 04:55:43,129 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-17 04:55:43,129 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-17 04:55:43,130 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-17 04:55:43,130 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-17 04:55:43,130 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-17 04:55:43,131 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-17 04:55:43,131 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-17 04:55:43,132 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-17 04:55:43,132 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-17 04:55:43,133 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-17 04:55:43,133 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-17 04:55:43,133 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-17 04:55:43,134 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-17 04:55:43,134 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-17 04:55:43,135 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-17 04:55:43,135 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-17 04:55:43,135 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-17 04:55:43,136 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-17 04:55:43,137 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-17 04:55:43,137 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-17 04:55:43,138 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-17 04:55:43,138 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-17 04:55:43,138 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-17 04:55:43,139 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-17 04:55:43,139 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-17 04:55:43,140 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-17 04:55:43,140 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-17 04:55:43,140 [salt.utils.extmods][INFO    ][24680] 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-17 04:55:43,141 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-17 04:55:43,141 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-17 04:55:43,147 [salt.utils.extmods][INFO    ][24680] Syncing states for environment 'base'
2017-09-17 04:55:43,148 [salt.utils.extmods][INFO    ][24680] Loading cache from salt://_states, for base)
2017-09-17 04:55:43,148 [salt.fileclient  ][INFO    ][24680] Caching directory '_states/' for environment 'base'
2017-09-17 04:55:43,222 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-17 04:55:43,240 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-17 04:55:43,282 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-17 04:55:43,295 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-17 04:55:43,390 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-17 04:55:43,434 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-17 04:55:43,446 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-17 04:55:43,459 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-17 04:55:43,471 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-17 04:55:43,489 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-17 04:55:43,569 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-17 04:55:43,597 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-17 04:55:43,615 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-17 04:55:43,640 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-17 04:55:43,667 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-17 04:55:43,691 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-17 04:55:43,710 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-17 04:55:43,721 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-17 04:55:43,742 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-17 04:55:43,771 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-17 04:55:43,784 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-17 04:55:43,797 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-17 04:55:43,834 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-17 04:55:43,931 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-17 04:55:43,998 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-17 04:55:44,070 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-17 04:55:44,099 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-17 04:55:44,124 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-17 04:55:44,144 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-17 04:55:44,154 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-17 04:55:44,154 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-17 04:55:44,155 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-17 04:55:44,155 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-17 04:55:44,156 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-17 04:55:44,156 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-17 04:55:44,157 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-17 04:55:44,158 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-17 04:55:44,158 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-17 04:55:44,159 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-17 04:55:44,160 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-17 04:55:44,160 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-17 04:55:44,161 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-17 04:55:44,161 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-17 04:55:44,161 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-17 04:55:44,162 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-17 04:55:44,162 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-17 04:55:44,163 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-17 04:55:44,163 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-17 04:55:44,164 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-17 04:55:44,164 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-17 04:55:44,165 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-17 04:55:44,165 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-17 04:55:44,166 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-17 04:55:44,167 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-17 04:55:44,167 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-17 04:55:44,168 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-17 04:55:44,169 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-17 04:55:44,169 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-17 04:55:44,170 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-17 04:55:44,173 [salt.utils.extmods][INFO    ][24680] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-17 04:55:44,179 [salt.utils.extmods][INFO    ][24680] Syncing sdb for environment 'base'
2017-09-17 04:55:44,179 [salt.utils.extmods][INFO    ][24680] Loading cache from salt://_sdb, for base)
2017-09-17 04:55:44,180 [salt.fileclient  ][INFO    ][24680] Caching directory '_sdb/' for environment 'base'
2017-09-17 04:55:44,238 [salt.utils.extmods][INFO    ][24680] Syncing grains for environment 'base'
2017-09-17 04:55:44,239 [salt.utils.extmods][INFO    ][24680] Loading cache from salt://_grains, for base)
2017-09-17 04:55:44,239 [salt.fileclient  ][INFO    ][24680] Caching directory '_grains/' for environment 'base'
2017-09-17 04:55:44,329 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-17 04:55:44,346 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-17 04:55:44,423 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-17 04:55:44,450 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-17 04:55:45,017 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-17 04:55:46,467 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-17 04:55:46,476 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-17 04:55:46,486 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-17 04:55:46,496 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-17 04:55:46,521 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-17 04:55:46,815 [salt.fileclient  ][INFO    ][24680] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-17 04:55:46,821 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-17 04:55:46,821 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-17 04:55:46,822 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-17 04:55:46,822 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-17 04:55:46,823 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-17 04:55:46,823 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-17 04:55:46,823 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-17 04:55:46,824 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-17 04:55:46,824 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-17 04:55:46,825 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-17 04:55:46,825 [salt.utils.extmods][INFO    ][24680] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-17 04:55:46,827 [salt.utils.extmods][INFO    ][24680] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-17 04:55:46,834 [salt.utils.extmods][INFO    ][24680] Syncing renderers for environment 'base'
2017-09-17 04:55:46,834 [salt.utils.extmods][INFO    ][24680] Loading cache from salt://_renderers, for base)
2017-09-17 04:55:46,834 [salt.fileclient  ][INFO    ][24680] Caching directory '_renderers/' for environment 'base'
2017-09-17 04:55:46,864 [salt.utils.extmods][INFO    ][24680] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-17 04:55:46,869 [salt.utils.extmods][INFO    ][24680] Syncing returners for environment 'base'
2017-09-17 04:55:46,869 [salt.utils.extmods][INFO    ][24680] Loading cache from salt://_returners, for base)
2017-09-17 04:55:46,870 [salt.fileclient  ][INFO    ][24680] Caching directory '_returners/' for environment 'base'
2017-09-17 04:55:46,901 [salt.utils.extmods][INFO    ][24680] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-17 04:55:46,906 [salt.utils.extmods][INFO    ][24680] Syncing output for environment 'base'
2017-09-17 04:55:46,906 [salt.utils.extmods][INFO    ][24680] Loading cache from salt://_output, for base)
2017-09-17 04:55:46,906 [salt.fileclient  ][INFO    ][24680] Caching directory '_output/' for environment 'base'
2017-09-17 04:55:46,946 [salt.utils.extmods][INFO    ][24680] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-17 04:55:46,951 [salt.utils.extmods][INFO    ][24680] Syncing utils for environment 'base'
2017-09-17 04:55:46,951 [salt.utils.extmods][INFO    ][24680] Loading cache from salt://_utils, for base)
2017-09-17 04:55:46,951 [salt.fileclient  ][INFO    ][24680] Caching directory '_utils/' for environment 'base'
2017-09-17 04:55:46,971 [salt.utils.extmods][INFO    ][24680] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-17 04:55:46,974 [salt.utils.extmods][INFO    ][24680] Syncing log_handlers for environment 'base'
2017-09-17 04:55:46,975 [salt.utils.extmods][INFO    ][24680] Loading cache from salt://_log_handlers, for base)
2017-09-17 04:55:46,975 [salt.fileclient  ][INFO    ][24680] Caching directory '_log_handlers/' for environment 'base'
2017-09-17 04:55:47,009 [salt.utils.extmods][INFO    ][24680] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-17 04:55:47,012 [salt.utils.extmods][INFO    ][24680] Syncing proxy for environment 'base'
2017-09-17 04:55:47,013 [salt.utils.extmods][INFO    ][24680] Loading cache from salt://_proxy, for base)
2017-09-17 04:55:47,013 [salt.fileclient  ][INFO    ][24680] Caching directory '_proxy/' for environment 'base'
2017-09-17 04:55:47,043 [salt.utils.extmods][INFO    ][24680] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-17 04:55:47,047 [salt.utils.extmods][INFO    ][24680] Syncing engines for environment 'base'
2017-09-17 04:55:47,048 [salt.utils.extmods][INFO    ][24680] Loading cache from salt://_engines, for base)
2017-09-17 04:55:47,048 [salt.fileclient  ][INFO    ][24680] Caching directory '_engines/' for environment 'base'
2017-09-17 04:55:47,078 [salt.minion      ][INFO    ][24680] Returning information for job: 20170917045537632081
2017-09-17 05:24:38,285 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command test.ping with jid 20170917052438282465
2017-09-17 05:24:38,311 [salt.minion      ][INFO    ][25327] Starting a new job with PID 25327
2017-09-17 05:24:38,374 [salt.minion      ][INFO    ][25327] Returning information for job: 20170917052438282465
2017-09-17 05:26:45,622 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command state.sls with jid 20170917052645611944
2017-09-17 05:26:45,643 [salt.minion      ][INFO    ][25360] Starting a new job with PID 25360
2017-09-17 05:26:46,076 [salt.state       ][INFO    ][25360] Loading fresh modules for state activity
2017-09-17 05:26:46,226 [salt.fileclient  ][INFO    ][25360] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-17 05:26:46,252 [salt.fileclient  ][INFO    ][25360] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-17 05:26:46,291 [salt.fileclient  ][INFO    ][25360] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-17 05:26:46,744 [salt.state       ][INFO    ][25360] Running state [lsof] at time 05:26:46.743701
2017-09-17 05:26:46,744 [salt.state       ][INFO    ][25360] Executing state pkg.installed for lsof
2017-09-17 05:26:46,744 [salt.loaded.int.module.cmdmod][INFO    ][25360] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-17 05:26:47,066 [salt.state       ][INFO    ][25360] Package lsof is already installed
2017-09-17 05:26:47,067 [salt.state       ][INFO    ][25360] Completed state [lsof] at time 05:26:47.066726 duration_in_ms=323.025
2017-09-17 05:26:47,067 [salt.state       ][INFO    ][25360] Running state [keepalived] at time 05:26:47.066939
2017-09-17 05:26:47,067 [salt.state       ][INFO    ][25360] Executing state pkg.installed for keepalived
2017-09-17 05:26:47,089 [salt.loaded.int.module.cmdmod][INFO    ][25360] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-17 05:26:49,532 [salt.loaded.int.module.cmdmod][INFO    ][25360] 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-17 05:26:55,667 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170917052655657935
2017-09-17 05:26:55,687 [salt.minion      ][INFO    ][26672] Starting a new job with PID 26672
2017-09-17 05:26:55,718 [salt.minion      ][INFO    ][26672] Returning information for job: 20170917052655657935
2017-09-17 05:26:58,919 [salt.loaded.int.module.cmdmod][INFO    ][25360] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-17 05:26:58,974 [salt.state       ][INFO    ][25360] 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-17 05:26:59,004 [salt.state       ][INFO    ][25360] Loading fresh modules for state activity
2017-09-17 05:26:59,033 [salt.state       ][INFO    ][25360] Completed state [keepalived] at time 05:26:59.033116 duration_in_ms=11966.175
2017-09-17 05:26:59,038 [salt.state       ][INFO    ][25360] Running state [/etc/keepalived/keepalived.conf] at time 05:26:59.038108
2017-09-17 05:26:59,039 [salt.state       ][INFO    ][25360] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-17 05:26:59,068 [salt.fileclient  ][INFO    ][25360] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-17 05:26:59,117 [salt.fileclient  ][INFO    ][25360] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-17 05:26:59,128 [salt.state       ][INFO    ][25360] File changed:
New file
2017-09-17 05:26:59,129 [salt.state       ][INFO    ][25360] Completed state [/etc/keepalived/keepalived.conf] at time 05:26:59.128687 duration_in_ms=90.579
2017-09-17 05:26:59,231 [salt.state       ][INFO    ][25360] Running state [keepalived] at time 05:26:59.231236
2017-09-17 05:26:59,232 [salt.state       ][INFO    ][25360] Executing state service.running for keepalived
2017-09-17 05:26:59,233 [salt.loaded.int.module.cmdmod][INFO    ][25360] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-17 05:26:59,251 [salt.loaded.int.module.cmdmod][INFO    ][25360] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-17 05:26:59,264 [salt.loaded.int.module.cmdmod][INFO    ][25360] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-17 05:26:59,279 [salt.loaded.int.module.cmdmod][INFO    ][25360] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-17 05:26:59,296 [salt.loaded.int.module.cmdmod][INFO    ][25360] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-17 05:26:59,374 [salt.loaded.int.module.cmdmod][INFO    ][25360] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-17 05:26:59,387 [salt.loaded.int.module.cmdmod][INFO    ][25360] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-17 05:26:59,399 [salt.loaded.int.module.cmdmod][INFO    ][25360] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-17 05:26:59,409 [salt.state       ][INFO    ][25360] {'keepalived': True}
2017-09-17 05:26:59,409 [salt.state       ][INFO    ][25360] Completed state [keepalived] at time 05:26:59.408863 duration_in_ms=177.627
2017-09-17 05:26:59,411 [salt.minion      ][INFO    ][25360] Returning information for job: 20170917052645611944
2017-09-17 05:28:43,603 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command pillar.get with jid 20170917052843597791
2017-09-17 05:28:43,631 [salt.minion      ][INFO    ][26984] Starting a new job with PID 26984
2017-09-17 05:28:43,639 [salt.minion      ][INFO    ][26984] Returning information for job: 20170917052843597791
2017-09-17 05:47:36,194 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command state.sls with jid 20170917054736179033
2017-09-17 05:47:36,213 [salt.minion      ][INFO    ][27299] Starting a new job with PID 27299
2017-09-17 05:47:38,694 [salt.state       ][INFO    ][27299] Loading fresh modules for state activity
2017-09-17 05:47:38,735 [salt.fileclient  ][INFO    ][27299] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-17 05:47:38,769 [salt.fileclient  ][INFO    ][27299] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-17 05:47:39,134 [salt.state       ][INFO    ][27299] Running state [attr] at time 05:47:39.134426
2017-09-17 05:47:39,135 [salt.state       ][INFO    ][27299] Executing state pkg.installed for attr
2017-09-17 05:47:39,135 [salt.loaded.int.module.cmdmod][INFO    ][27299] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-17 05:47:39,520 [salt.loaded.int.module.cmdmod][INFO    ][27299] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-17 05:47:41,793 [salt.loaded.int.module.cmdmod][INFO    ][27299] 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-17 05:47:44,889 [salt.loaded.int.module.cmdmod][INFO    ][27299] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-17 05:47:44,941 [salt.state       ][INFO    ][27299] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-17 05:47:44,959 [salt.state       ][INFO    ][27299] Loading fresh modules for state activity
2017-09-17 05:47:44,985 [salt.state       ][INFO    ][27299] Completed state [attr] at time 05:47:44.984442 duration_in_ms=5850.015
2017-09-17 05:47:44,996 [salt.state       ][INFO    ][27299] Running state [glusterfs-server] at time 05:47:44.995512
2017-09-17 05:47:44,996 [salt.state       ][INFO    ][27299] Executing state pkg.installed for glusterfs-server
2017-09-17 05:47:45,326 [salt.loaded.int.module.cmdmod][INFO    ][27299] 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-17 05:47:46,283 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170917054746272814
2017-09-17 05:47:46,303 [salt.minion      ][INFO    ][28297] Starting a new job with PID 28297
2017-09-17 05:47:46,323 [salt.minion      ][INFO    ][28297] Returning information for job: 20170917054746272814
2017-09-17 05:47:56,487 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170917054756476615
2017-09-17 05:47:56,508 [salt.minion      ][INFO    ][31008] Starting a new job with PID 31008
2017-09-17 05:47:56,530 [salt.minion      ][INFO    ][31008] Returning information for job: 20170917054756476615
2017-09-17 05:48:06,587 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170917054806577659
2017-09-17 05:48:06,605 [salt.minion      ][INFO    ][31604] Starting a new job with PID 31604
2017-09-17 05:48:06,627 [salt.minion      ][INFO    ][31604] Returning information for job: 20170917054806577659
2017-09-17 05:48:06,836 [salt.loaded.int.module.cmdmod][INFO    ][27299] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-17 05:48:06,890 [salt.state       ][INFO    ][27299] 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-17 05:48:06,911 [salt.state       ][INFO    ][27299] Loading fresh modules for state activity
2017-09-17 05:48:06,942 [salt.state       ][INFO    ][27299] Completed state [glusterfs-server] at time 05:48:06.941660 duration_in_ms=21946.146
2017-09-17 05:48:06,952 [salt.state       ][INFO    ][27299] Running state [bc] at time 05:48:06.951682
2017-09-17 05:48:06,952 [salt.state       ][INFO    ][27299] Executing state pkg.installed for bc
2017-09-17 05:48:07,275 [salt.loaded.int.module.cmdmod][INFO    ][27299] 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-17 05:48:10,797 [salt.loaded.int.module.cmdmod][INFO    ][27299] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-17 05:48:10,854 [salt.state       ][INFO    ][27299] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-17 05:48:10,871 [salt.state       ][INFO    ][27299] Loading fresh modules for state activity
2017-09-17 05:48:10,895 [salt.state       ][INFO    ][27299] Completed state [bc] at time 05:48:10.895263 duration_in_ms=3943.579
2017-09-17 05:48:11,018 [salt.state       ][INFO    ][27299] Running state [glusterfs-server] at time 05:48:11.018022
2017-09-17 05:48:11,019 [salt.state       ][INFO    ][27299] Executing state service.running for glusterfs-server
2017-09-17 05:48:11,022 [salt.loaded.int.module.cmdmod][INFO    ][27299] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-17 05:48:11,039 [salt.loaded.int.module.cmdmod][INFO    ][27299] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-17 05:48:11,051 [salt.loaded.int.module.cmdmod][INFO    ][27299] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-17 05:48:11,065 [salt.state       ][INFO    ][27299] The service glusterfs-server is already running
2017-09-17 05:48:11,066 [salt.state       ][INFO    ][27299] Completed state [glusterfs-server] at time 05:48:11.065557 duration_in_ms=47.537
2017-09-17 05:48:11,068 [salt.state       ][INFO    ][27299] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 05:48:11.068274
2017-09-17 05:48:11,069 [salt.state       ][INFO    ][27299] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-17 05:48:11,094 [salt.state       ][INFO    ][27299] File changed:
New file
2017-09-17 05:48:11,095 [salt.state       ][INFO    ][27299] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 05:48:11.094697 duration_in_ms=26.423
2017-09-17 05:48:11,095 [salt.state       ][INFO    ][27299] Running state [/srv/glusterfs/glance] at time 05:48:11.095033
2017-09-17 05:48:11,095 [salt.state       ][INFO    ][27299] Executing state file.directory for /srv/glusterfs/glance
2017-09-17 05:48:11,097 [salt.state       ][INFO    ][27299] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-17 05:48:11,097 [salt.state       ][INFO    ][27299] Completed state [/srv/glusterfs/glance] at time 05:48:11.096755 duration_in_ms=1.722
2017-09-17 05:48:11,097 [salt.state       ][INFO    ][27299] Running state [/srv/glusterfs/keystone-keys] at time 05:48:11.097059
2017-09-17 05:48:11,097 [salt.state       ][INFO    ][27299] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-17 05:48:11,098 [salt.state       ][INFO    ][27299] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-17 05:48:11,099 [salt.state       ][INFO    ][27299] Completed state [/srv/glusterfs/keystone-keys] at time 05:48:11.098443 duration_in_ms=1.384
2017-09-17 05:48:11,099 [salt.state       ][INFO    ][27299] Running state [/srv/glusterfs/nova_instances] at time 05:48:11.098754
2017-09-17 05:48:11,099 [salt.state       ][INFO    ][27299] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-17 05:48:11,100 [salt.state       ][INFO    ][27299] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-17 05:48:11,100 [salt.state       ][INFO    ][27299] Completed state [/srv/glusterfs/nova_instances] at time 05:48:11.100146 duration_in_ms=1.392
2017-09-17 05:48:11,101 [salt.state       ][INFO    ][27299] Running state [/srv/glusterfs/keystone-credential-keys] at time 05:48:11.100467
2017-09-17 05:48:11,101 [salt.state       ][INFO    ][27299] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-17 05:48:11,102 [salt.state       ][INFO    ][27299] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-17 05:48:11,102 [salt.state       ][INFO    ][27299] Completed state [/srv/glusterfs/keystone-credential-keys] at time 05:48:11.101823 duration_in_ms=1.356
2017-09-17 05:48:11,103 [salt.minion      ][INFO    ][27299] Returning information for job: 20170917054736179033
2017-09-17 05:48:12,278 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command test.ping with jid 20170917054812270067
2017-09-17 05:48:12,297 [salt.minion      ][INFO    ][32047] Starting a new job with PID 32047
2017-09-17 05:48:12,352 [salt.minion      ][INFO    ][32047] Returning information for job: 20170917054812270067
2017-09-17 05:48:12,479 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command state.sls with jid 20170917054812469491
2017-09-17 05:48:12,499 [salt.minion      ][INFO    ][32052] Starting a new job with PID 32052
2017-09-17 05:48:13,982 [salt.state       ][INFO    ][32052] Loading fresh modules for state activity
2017-09-17 05:48:14,022 [salt.fileclient  ][INFO    ][32052] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-17 05:48:14,077 [salt.fileclient  ][INFO    ][32052] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-17 05:48:14,175 [salt.fileclient  ][INFO    ][32052] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-17 05:48:14,199 [salt.fileclient  ][INFO    ][32052] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-17 05:48:14,584 [salt.state       ][INFO    ][32052] Running state [attr] at time 05:48:14.583521
2017-09-17 05:48:14,584 [salt.state       ][INFO    ][32052] Executing state pkg.installed for attr
2017-09-17 05:48:14,584 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-17 05:48:14,977 [salt.state       ][INFO    ][32052] Package attr is already installed
2017-09-17 05:48:14,978 [salt.state       ][INFO    ][32052] Completed state [attr] at time 05:48:14.977544 duration_in_ms=394.023
2017-09-17 05:48:14,987 [salt.state       ][INFO    ][32052] Running state [glusterfs-server] at time 05:48:14.987355
2017-09-17 05:48:14,988 [salt.state       ][INFO    ][32052] Executing state pkg.installed for glusterfs-server
2017-09-17 05:48:14,996 [salt.state       ][INFO    ][32052] Package glusterfs-server is already installed
2017-09-17 05:48:14,996 [salt.state       ][INFO    ][32052] Completed state [glusterfs-server] at time 05:48:14.996126 duration_in_ms=8.77
2017-09-17 05:48:14,997 [salt.state       ][INFO    ][32052] Running state [bc] at time 05:48:14.996533
2017-09-17 05:48:14,997 [salt.state       ][INFO    ][32052] Executing state pkg.installed for bc
2017-09-17 05:48:15,004 [salt.state       ][INFO    ][32052] Package bc is already installed
2017-09-17 05:48:15,004 [salt.state       ][INFO    ][32052] Completed state [bc] at time 05:48:15.004264 duration_in_ms=7.73
2017-09-17 05:48:15,006 [salt.state       ][INFO    ][32052] Running state [glusterfs-server] at time 05:48:15.006110
2017-09-17 05:48:15,007 [salt.state       ][INFO    ][32052] Executing state service.running for glusterfs-server
2017-09-17 05:48:15,007 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-17 05:48:15,026 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-17 05:48:15,118 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-17 05:48:15,146 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-17 05:48:15,159 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-17 05:48:15,174 [salt.state       ][INFO    ][32052] The service glusterfs-server is already running
2017-09-17 05:48:15,175 [salt.state       ][INFO    ][32052] Completed state [glusterfs-server] at time 05:48:15.174778 duration_in_ms=168.667
2017-09-17 05:48:15,181 [salt.state       ][INFO    ][32052] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 05:48:15.180560
2017-09-17 05:48:15,181 [salt.state       ][INFO    ][32052] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-17 05:48:15,190 [salt.state       ][INFO    ][32052] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-17 05:48:15,191 [salt.state       ][INFO    ][32052] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 05:48:15.190752 duration_in_ms=10.191
2017-09-17 05:48:15,191 [salt.state       ][INFO    ][32052] Running state [/srv/glusterfs/glance] at time 05:48:15.191098
2017-09-17 05:48:15,191 [salt.state       ][INFO    ][32052] Executing state file.directory for /srv/glusterfs/glance
2017-09-17 05:48:15,192 [salt.state       ][INFO    ][32052] Directory /srv/glusterfs/glance is in the correct state
2017-09-17 05:48:15,192 [salt.state       ][INFO    ][32052] Completed state [/srv/glusterfs/glance] at time 05:48:15.192416 duration_in_ms=1.318
2017-09-17 05:48:15,193 [salt.state       ][INFO    ][32052] Running state [/srv/glusterfs/keystone-keys] at time 05:48:15.192751
2017-09-17 05:48:15,193 [salt.state       ][INFO    ][32052] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-17 05:48:15,194 [salt.state       ][INFO    ][32052] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-17 05:48:15,194 [salt.state       ][INFO    ][32052] Completed state [/srv/glusterfs/keystone-keys] at time 05:48:15.194008 duration_in_ms=1.257
2017-09-17 05:48:15,194 [salt.state       ][INFO    ][32052] Running state [/srv/glusterfs/nova_instances] at time 05:48:15.194351
2017-09-17 05:48:15,195 [salt.state       ][INFO    ][32052] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-17 05:48:15,195 [salt.state       ][INFO    ][32052] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-17 05:48:15,196 [salt.state       ][INFO    ][32052] Completed state [/srv/glusterfs/nova_instances] at time 05:48:15.195614 duration_in_ms=1.263
2017-09-17 05:48:15,196 [salt.state       ][INFO    ][32052] Running state [/srv/glusterfs/keystone-credential-keys] at time 05:48:15.195969
2017-09-17 05:48:15,196 [salt.state       ][INFO    ][32052] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-17 05:48:15,197 [salt.state       ][INFO    ][32052] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-17 05:48:15,197 [salt.state       ][INFO    ][32052] Completed state [/srv/glusterfs/keystone-credential-keys] at time 05:48:15.197215 duration_in_ms=1.246
2017-09-17 05:48:15,293 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command ['git', '--version'] in directory '/root'
2017-09-17 05:48:15,366 [salt.state       ][INFO    ][32052] Running state [sleep 5] at time 05:48:15.366276
2017-09-17 05:48:15,367 [salt.state       ][INFO    ][32052] Executing state cmd.wait for sleep 5
2017-09-17 05:48:15,367 [salt.state       ][INFO    ][32052] No changes made for sleep 5
2017-09-17 05:48:15,367 [salt.state       ][INFO    ][32052] Completed state [sleep 5] at time 05:48:15.367051 duration_in_ms=0.777
2017-09-17 05:48:15,368 [salt.state       ][INFO    ][32052] Running state [10.167.4.141] at time 05:48:15.367528
2017-09-17 05:48:15,368 [salt.state       ][INFO    ][32052] Executing state glusterfs.peered for 10.167.4.141
2017-09-17 05:48:15,368 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:15,385 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:15,494 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:15,511 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:15,920 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:15,938 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:16,060 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:16,079 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:16,215 [salt.state       ][INFO    ][32052] {'new': {'10.167.4.141': []}, 'old': None}
2017-09-17 05:48:16,215 [salt.state       ][INFO    ][32052] Completed state [10.167.4.141] at time 05:48:16.215127 duration_in_ms=847.596
2017-09-17 05:48:16,221 [salt.state       ][INFO    ][32052] Running state [10.167.4.142] at time 05:48:16.221411
2017-09-17 05:48:16,222 [salt.state       ][INFO    ][32052] Executing state glusterfs.peered for 10.167.4.142
2017-09-17 05:48:16,223 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:16,241 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:16,350 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:16,370 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:16,560 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:16,579 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:16,687 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:16,705 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:16,813 [salt.state       ][INFO    ][32052] Peering with localhost is not needed
2017-09-17 05:48:16,813 [salt.state       ][INFO    ][32052] Completed state [10.167.4.142] at time 05:48:16.813284 duration_in_ms=591.872
2017-09-17 05:48:16,819 [salt.state       ][INFO    ][32052] Running state [10.167.4.143] at time 05:48:16.819198
2017-09-17 05:48:16,820 [salt.state       ][INFO    ][32052] Executing state glusterfs.peered for 10.167.4.143
2017-09-17 05:48:16,821 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:16,838 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:16,946 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:16,962 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:17,329 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:17,348 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:17,462 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:17,477 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:17,624 [salt.state       ][INFO    ][32052] {'new': {'10.167.4.141': [], '10.167.4.143': []}, 'old': {'10.167.4.141': []}}
2017-09-17 05:48:17,624 [salt.state       ][INFO    ][32052] Completed state [10.167.4.143] at time 05:48:17.624298 duration_in_ms=805.099
2017-09-17 05:48:17,626 [salt.state       ][INFO    ][32052] Running state [glance] at time 05:48:17.626277
2017-09-17 05:48:17,627 [salt.state       ][INFO    ][32052] Executing state glusterfs.created for glance
2017-09-17 05:48:17,628 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:17,648 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:17,757 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:17,774 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:18,712 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:18,730 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:19,976 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:19,995 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:20,100 [salt.state       ][INFO    ][32052] {'new': ['glance'], 'old': []}
2017-09-17 05:48:20,100 [salt.state       ][INFO    ][32052] Completed state [glance] at time 05:48:20.100396 duration_in_ms=2474.118
2017-09-17 05:48:20,108 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 05:48:20.107913
2017-09-17 05:48:20,108 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-17 05:48:20,109 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-17 05:48:20,218 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-09-17 05:48:20,952 [salt.state       ][INFO    ][32052] {'pid': 32275, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:20,953 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 05:48:20.952778 duration_in_ms=844.865
2017-09-17 05:48:20,954 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 05:48:20.953947
2017-09-17 05:48:20,955 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-17 05:48:20,956 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-17 05:48:21,065 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-09-17 05:48:21,762 [salt.state       ][INFO    ][32052] {'pid': 32294, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:21,762 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 05:48:21.762335 duration_in_ms=808.388
2017-09-17 05:48:21,764 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 05:48:21.763475
2017-09-17 05:48:21,764 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-17 05:48:21,765 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-17 05:48:21,875 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-09-17 05:48:22,523 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170917054822510472
2017-09-17 05:48:22,544 [salt.minion      ][INFO    ][32321] Starting a new job with PID 32321
2017-09-17 05:48:22,565 [salt.minion      ][INFO    ][32321] Returning information for job: 20170917054822510472
2017-09-17 05:48:24,622 [salt.state       ][INFO    ][32052] {'pid': 32311, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:24,623 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 05:48:24.622395 duration_in_ms=2858.919
2017-09-17 05:48:24,624 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 05:48:24.623558
2017-09-17 05:48:24,624 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-17 05:48:24,625 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-17 05:48:24,729 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-09-17 05:48:25,435 [salt.state       ][INFO    ][32052] {'pid': 32336, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:25,436 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 05:48:25.435835 duration_in_ms=812.274
2017-09-17 05:48:25,437 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 05:48:25.436956
2017-09-17 05:48:25,438 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-17 05:48:25,439 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-17 05:48:25,545 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-09-17 05:48:26,232 [salt.state       ][INFO    ][32052] {'pid': 32353, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:26,233 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 05:48:26.232441 duration_in_ms=795.483
2017-09-17 05:48:26,235 [salt.state       ][INFO    ][32052] Running state [glance] at time 05:48:26.235014
2017-09-17 05:48:26,236 [salt.state       ][INFO    ][32052] Executing state glusterfs.started for glance
2017-09-17 05:48:26,237 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:26,255 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:26,366 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:26,384 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:26,493 [salt.state       ][INFO    ][32052] Volume glance is already started
2017-09-17 05:48:26,493 [salt.state       ][INFO    ][32052] Completed state [glance] at time 05:48:26.493094 duration_in_ms=258.079
2017-09-17 05:48:26,495 [salt.state       ][INFO    ][32052] Running state [keystone-keys] at time 05:48:26.495074
2017-09-17 05:48:26,496 [salt.state       ][INFO    ][32052] Executing state glusterfs.created for keystone-keys
2017-09-17 05:48:26,497 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:26,513 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:26,617 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:26,635 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:27,434 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:27,452 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:30,323 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:30,345 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:30,456 [salt.state       ][INFO    ][32052] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-09-17 05:48:30,457 [salt.state       ][INFO    ][32052] Completed state [keystone-keys] at time 05:48:30.456698 duration_in_ms=3961.623
2017-09-17 05:48:30,465 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 05:48:30.464476
2017-09-17 05:48:30,465 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-17 05:48:30,466 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-17 05:48:30,567 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-09-17 05:48:31,242 [salt.state       ][INFO    ][32052] {'pid': 32465, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:31,243 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 05:48:31.242969 duration_in_ms=778.492
2017-09-17 05:48:31,244 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 05:48:31.244158
2017-09-17 05:48:31,245 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-17 05:48:31,246 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-17 05:48:31,362 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-09-17 05:48:32,052 [salt.state       ][INFO    ][32052] {'pid': 32482, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:32,052 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 05:48:32.052121 duration_in_ms=807.96
2017-09-17 05:48:32,053 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 05:48:32.053241
2017-09-17 05:48:32,054 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-17 05:48:32,055 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-17 05:48:32,161 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-09-17 05:48:32,681 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170917054832669132
2017-09-17 05:48:32,701 [salt.minion      ][INFO    ][32510] Starting a new job with PID 32510
2017-09-17 05:48:32,722 [salt.minion      ][INFO    ][32510] Returning information for job: 20170917054832669132
2017-09-17 05:48:33,003 [salt.state       ][INFO    ][32052] {'pid': 32500, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:33,004 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 05:48:33.003775 duration_in_ms=950.533
2017-09-17 05:48:33,005 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 05:48:33.004922
2017-09-17 05:48:33,005 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-17 05:48:33,007 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-17 05:48:33,119 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-09-17 05:48:35,863 [salt.state       ][INFO    ][32052] {'pid': 32525, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:35,864 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 05:48:35.864008 duration_in_ms=2859.085
2017-09-17 05:48:35,865 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 05:48:35.865117
2017-09-17 05:48:35,866 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-17 05:48:35,867 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-17 05:48:35,980 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-09-17 05:48:36,671 [salt.state       ][INFO    ][32052] {'pid': 32543, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:36,672 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 05:48:36.671435 duration_in_ms=806.318
2017-09-17 05:48:36,674 [salt.state       ][INFO    ][32052] Running state [keystone-keys] at time 05:48:36.673742
2017-09-17 05:48:36,674 [salt.state       ][INFO    ][32052] Executing state glusterfs.started for keystone-keys
2017-09-17 05:48:36,675 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:36,694 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:36,805 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:36,824 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:36,940 [salt.state       ][INFO    ][32052] Volume keystone-keys is already started
2017-09-17 05:48:36,940 [salt.state       ][INFO    ][32052] Completed state [keystone-keys] at time 05:48:36.940176 duration_in_ms=266.431
2017-09-17 05:48:36,942 [salt.state       ][INFO    ][32052] Running state [nova_instances] at time 05:48:36.942211
2017-09-17 05:48:36,943 [salt.state       ][INFO    ][32052] Executing state glusterfs.created for nova_instances
2017-09-17 05:48:36,944 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:36,961 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:37,067 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:37,086 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:37,963 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:37,984 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:40,907 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:40,928 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:41,039 [salt.state       ][INFO    ][32052] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-09-17 05:48:41,039 [salt.state       ][INFO    ][32052] Completed state [nova_instances] at time 05:48:41.039046 duration_in_ms=4096.834
2017-09-17 05:48:41,048 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 05:48:41.047526
2017-09-17 05:48:41,048 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-17 05:48:41,049 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-17 05:48:41,154 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-09-17 05:48:41,867 [salt.state       ][INFO    ][32052] {'pid': 32658, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:41,868 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 05:48:41.868104 duration_in_ms=820.577
2017-09-17 05:48:41,869 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 05:48:41.869373
2017-09-17 05:48:41,870 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-09-17 05:48:41,871 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-17 05:48:41,977 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-09-17 05:48:42,696 [salt.state       ][INFO    ][32052] {'pid': 32676, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:42,697 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 05:48:42.696740 duration_in_ms=827.366
2017-09-17 05:48:42,698 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 05:48:42.697963
2017-09-17 05:48:42,699 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-09-17 05:48:42,700 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-17 05:48:42,810 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'True'' in directory '/root'
2017-09-17 05:48:42,840 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170917054842829059
2017-09-17 05:48:42,863 [salt.minion      ][INFO    ][32699] Starting a new job with PID 32699
2017-09-17 05:48:42,882 [salt.minion      ][INFO    ][32699] Returning information for job: 20170917054842829059
2017-09-17 05:48:43,562 [salt.state       ][INFO    ][32052] {'pid': 32693, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:43,562 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 05:48:43.562322 duration_in_ms=864.358
2017-09-17 05:48:43,563 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 05:48:43.563354
2017-09-17 05:48:43,564 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-09-17 05:48:43,565 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-09-17 05:48:43,671 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'True'' in directory '/root'
2017-09-17 05:48:46,408 [salt.state       ][INFO    ][32052] {'pid': 32718, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:46,409 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 05:48:46.408595 duration_in_ms=2845.24
2017-09-17 05:48:46,410 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 05:48:46.409793
2017-09-17 05:48:46,410 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-17 05:48:46,411 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-17 05:48:46,523 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-09-17 05:48:47,222 [salt.state       ][INFO    ][32052] {'pid': 32736, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:47,223 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 05:48:47.222662 duration_in_ms=812.869
2017-09-17 05:48:47,225 [salt.state       ][INFO    ][32052] Running state [nova_instances] at time 05:48:47.225232
2017-09-17 05:48:47,226 [salt.state       ][INFO    ][32052] Executing state glusterfs.started for nova_instances
2017-09-17 05:48:47,227 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:47,245 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:47,355 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:47,370 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:47,471 [salt.state       ][INFO    ][32052] Volume nova_instances is already started
2017-09-17 05:48:47,472 [salt.state       ][INFO    ][32052] Completed state [nova_instances] at time 05:48:47.471408 duration_in_ms=246.175
2017-09-17 05:48:47,474 [salt.state       ][INFO    ][32052] Running state [keystone-credential-keys] at time 05:48:47.473607
2017-09-17 05:48:47,474 [salt.state       ][INFO    ][32052] Executing state glusterfs.created for keystone-credential-keys
2017-09-17 05:48:47,475 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:47,491 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:47,597 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:47,613 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:48,398 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:48,416 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:51,409 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:51,431 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:51,539 [salt.state       ][INFO    ][32052] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-09-17 05:48:51,540 [salt.state       ][INFO    ][32052] Completed state [keystone-credential-keys] at time 05:48:51.539771 duration_in_ms=4066.163
2017-09-17 05:48:51,549 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 05:48:51.549004
2017-09-17 05:48:51,550 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-17 05:48:51,551 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-17 05:48:51,655 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-09-17 05:48:52,387 [salt.state       ][INFO    ][32052] {'pid': 389, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:52,387 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 05:48:52.387087 duration_in_ms=838.082
2017-09-17 05:48:52,388 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 05:48:52.388246
2017-09-17 05:48:52,389 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-17 05:48:52,390 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-17 05:48:52,499 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-09-17 05:48:53,001 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command saltutil.find_job with jid 20170917054852989693
2017-09-17 05:48:53,023 [salt.minion      ][INFO    ][417] Starting a new job with PID 417
2017-09-17 05:48:53,041 [salt.minion      ][INFO    ][417] Returning information for job: 20170917054852989693
2017-09-17 05:48:53,232 [salt.state       ][INFO    ][32052] {'pid': 406, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:53,233 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 05:48:53.232879 duration_in_ms=844.632
2017-09-17 05:48:53,234 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 05:48:53.234021
2017-09-17 05:48:53,235 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-17 05:48:53,236 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-17 05:48:53,348 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-09-17 05:48:56,125 [salt.state       ][INFO    ][32052] {'pid': 429, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:56,125 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 05:48:56.125286 duration_in_ms=2891.264
2017-09-17 05:48:56,126 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 05:48:56.126394
2017-09-17 05:48:56,127 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-17 05:48:56,128 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-17 05:48:56,240 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-09-17 05:48:56,952 [salt.state       ][INFO    ][32052] {'pid': 449, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:56,953 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 05:48:56.952510 duration_in_ms=826.116
2017-09-17 05:48:56,954 [salt.state       ][INFO    ][32052] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 05:48:56.953635
2017-09-17 05:48:56,954 [salt.state       ][INFO    ][32052] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-17 05:48:56,955 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-17 05:48:57,063 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-09-17 05:48:57,802 [salt.state       ][INFO    ][32052] {'pid': 467, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-09-17 05:48:57,803 [salt.state       ][INFO    ][32052] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 05:48:57.802752 duration_in_ms=849.117
2017-09-17 05:48:57,805 [salt.state       ][INFO    ][32052] Running state [keystone-credential-keys] at time 05:48:57.805361
2017-09-17 05:48:57,806 [salt.state       ][INFO    ][32052] Executing state glusterfs.started for keystone-credential-keys
2017-09-17 05:48:57,807 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:57,826 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:57,935 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --version' in directory '/root'
2017-09-17 05:48:57,954 [salt.loaded.int.module.cmdmod][INFO    ][32052] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-17 05:48:58,060 [salt.state       ][INFO    ][32052] Volume keystone-credential-keys is already started
2017-09-17 05:48:58,061 [salt.state       ][INFO    ][32052] Completed state [keystone-credential-keys] at time 05:48:58.060974 duration_in_ms=255.612
2017-09-17 05:48:58,065 [salt.minion      ][INFO    ][32052] Returning information for job: 20170917054812469491
2017-09-17 05:49:07,941 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command test.ping with jid 20170917054907931206
2017-09-17 05:49:07,961 [salt.minion      ][INFO    ][508] Starting a new job with PID 508
2017-09-17 05:49:08,011 [salt.minion      ][INFO    ][508] Returning information for job: 20170917054907931206
2017-09-17 05:49:08,150 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command cmd.run with jid 20170917054908129351
2017-09-17 05:49:08,169 [salt.minion      ][INFO    ][513] Starting a new job with PID 513
2017-09-17 05:49:08,177 [salt.loaded.int.module.cmdmod][INFO    ][513] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-17 05:49:08,396 [salt.minion      ][INFO    ][513] Returning information for job: 20170917054908129351
2017-09-17 05:54:27,551 [salt.utils.schedule][INFO    ][24567] Running scheduled job: __mine_interval
2017-09-17 06:54:27,551 [salt.utils.schedule][INFO    ][24567] Running scheduled job: __mine_interval
2017-09-17 06:56:46,880 [salt.minion      ][INFO    ][24567] User sudo_ubuntu Executing command cp.push_dir with jid 20170917065646871674
2017-09-17 06:56:46,904 [salt.minion      ][INFO    ][1777] Starting a new job with PID 1777
