2017-11-27 21:47:48,735 [salt.cli.daemons ][WARNING ][2289] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-27 21:48:56,973 [salt.state       ][ERROR   ][3781] No contents found in top file
2017-11-27 21:50:27,690 [salt.utils.parsers][WARNING ][2289] Minion received a SIGTERM. Exiting.
2017-11-27 21:54:56,593 [salt.cli.daemons ][WARNING ][3268] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-27 21:55:24,580 [salt.transport.ipc][ERROR   ][3268] Exception occurred while handling stream: [Errno 0] Success
2017-11-27 21:57:01,554 [py.warnings      ][WARNING ][13559] /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-11-27 21:57:22,869 [salt.transport.ipc][ERROR   ][3268] Exception occurred while handling stream: [Errno 0] Success
2017-11-27 22:01:05,985 [salt.loaded.int.module.cmdmod][ERROR   ][13559] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-27 22:01:05,988 [salt.loaded.int.module.cmdmod][ERROR   ][13559] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-27 22:01:10,984 [salt.loaded.int.module.cmdmod][ERROR   ][13559] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-27 22:01:10,985 [salt.loaded.int.module.cmdmod][ERROR   ][13559] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-27 22:01:15,921 [salt.loaded.int.module.cmdmod][ERROR   ][13559] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-27 22:01:15,924 [salt.loaded.int.module.cmdmod][ERROR   ][13559] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-27 22:01:21,112 [salt.loaded.int.module.cmdmod][ERROR   ][13559] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-27 22:01:21,113 [salt.loaded.int.module.cmdmod][ERROR   ][13559] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-27 22:01:25,169 [salt.loaded.int.module.cmdmod][ERROR   ][13559] 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-11-27 22:01:28,478 [salt.loaded.int.module.cmdmod][INFO    ][20785] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-27 22:01:28,488 [salt.loaded.int.module.cmdmod][INFO    ][20785] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-27 22:01:28,505 [salt.loaded.int.module.cmdmod][INFO    ][20785] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-27 22:01:28,524 [salt.utils.parsers][WARNING ][3268] Minion received a SIGTERM. Exiting.
2017-11-27 22:01:29,026 [salt.cli.daemons ][INFO    ][20860] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-ha.local"
2017-11-27 22:01:29,949 [salt.minion      ][INFO    ][20860] Creating minion process manager
2017-11-27 22:01:29,950 [salt.cli.daemons ][WARNING ][20860] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-27 22:01:29,950 [salt.cli.daemons ][INFO    ][20860] The Salt Minion is starting up
2017-11-27 22:01:29,951 [salt.minion      ][INFO    ][20860] Minion is starting as user 'root'
2017-11-27 22:01:29,951 [salt.utils.event ][INFO    ][20860] Starting pull socket on /var/run/salt/minion/minion_event_a1b2f32648_pull.ipc
2017-11-27 22:01:31,393 [salt.loaded.int.module.cmdmod][INFO    ][20860] Executing command ['date', '+%z'] in directory '/root'
2017-11-27 22:01:31,412 [salt.utils.schedule][INFO    ][20860] Updating job settings for scheduled job: __mine_interval
2017-11-27 22:01:31,417 [salt.minion      ][INFO    ][20860] Added mine.update to scheduler
2017-11-27 22:01:31,447 [salt.minion      ][INFO    ][20860] Minion is ready to receive requests!
2017-11-27 22:01:32,449 [salt.utils.schedule][INFO    ][20860] Running scheduled job: __mine_interval
2017-11-27 22:07:15,212 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171127220715201668
2017-11-27 22:07:15,235 [salt.minion      ][INFO    ][21041] Starting a new job with PID 21041
2017-11-27 22:07:17,868 [salt.state       ][INFO    ][21041] Loading fresh modules for state activity
2017-11-27 22:07:17,900 [salt.state       ][ERROR   ][21041] No contents found in top file
2017-11-27 22:07:17,901 [salt.utils.extmods][INFO    ][21041] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-27 22:07:17,909 [salt.utils.extmods][INFO    ][21041] Syncing beacons for environment 'base'
2017-11-27 22:07:17,909 [salt.utils.extmods][INFO    ][21041] Loading cache from salt://_beacons, for base)
2017-11-27 22:07:17,909 [salt.fileclient  ][INFO    ][21041] Caching directory '_beacons/' for environment 'base'
2017-11-27 22:07:17,956 [salt.utils.extmods][INFO    ][21041] Syncing modules for environment 'base'
2017-11-27 22:07:17,957 [salt.utils.extmods][INFO    ][21041] Loading cache from salt://_modules, for base)
2017-11-27 22:07:17,957 [salt.fileclient  ][INFO    ][21041] Caching directory '_modules/' for environment 'base'
2017-11-27 22:07:18,005 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-11-27 22:07:18,016 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-27 22:07:18,031 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-27 22:07:18,050 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-27 22:07:18,064 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-27 22:07:18,076 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-27 22:07:18,089 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-27 22:07:18,463 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-27 22:07:18,479 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-27 22:07:18,495 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-27 22:07:18,507 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-27 22:07:18,521 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-27 22:07:18,538 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-27 22:07:18,550 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-27 22:07:18,562 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-27 22:07:18,574 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-27 22:07:18,589 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-27 22:07:18,601 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-27 22:07:18,613 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-27 22:07:18,626 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-27 22:07:18,637 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-27 22:07:18,650 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-27 22:07:18,666 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-27 22:07:18,684 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-27 22:07:18,698 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-27 22:07:18,713 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-27 22:07:18,726 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-27 22:07:18,738 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-27 22:07:18,752 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-27 22:07:18,772 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-27 22:07:18,786 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-27 22:07:18,800 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-27 22:07:18,816 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-27 22:07:18,833 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-27 22:07:18,841 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-27 22:07:18,841 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-11-27 22:07:18,843 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-27 22:07:18,843 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-27 22:07:18,844 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-27 22:07:18,845 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-27 22:07:18,845 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-27 22:07:18,846 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-27 22:07:18,846 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-27 22:07:18,847 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-27 22:07:18,847 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-27 22:07:18,848 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-27 22:07:18,848 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-27 22:07:18,849 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-27 22:07:18,849 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-27 22:07:18,850 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-27 22:07:18,850 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-27 22:07:18,851 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-27 22:07:18,852 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-27 22:07:18,853 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-27 22:07:18,853 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-27 22:07:18,854 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-27 22:07:18,854 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-27 22:07:18,855 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-27 22:07:18,857 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-27 22:07:18,857 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-27 22:07:18,858 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-27 22:07:18,859 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-27 22:07:18,859 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-27 22:07:18,860 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-27 22:07:18,861 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-27 22:07:18,861 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-27 22:07:18,862 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-27 22:07:18,862 [salt.utils.extmods][INFO    ][21041] 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-11-27 22:07:18,863 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-27 22:07:18,863 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-27 22:07:18,875 [salt.utils.extmods][INFO    ][21041] Syncing states for environment 'base'
2017-11-27 22:07:18,875 [salt.utils.extmods][INFO    ][21041] Loading cache from salt://_states, for base)
2017-11-27 22:07:18,876 [salt.fileclient  ][INFO    ][21041] Caching directory '_states/' for environment 'base'
2017-11-27 22:07:18,930 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-11-27 22:07:18,946 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-27 22:07:18,958 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-27 22:07:18,971 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-27 22:07:18,989 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-27 22:07:19,005 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-27 22:07:19,021 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-27 22:07:19,036 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-27 22:07:19,053 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-27 22:07:19,064 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-11-27 22:07:19,080 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-27 22:07:19,093 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-27 22:07:19,108 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-27 22:07:19,121 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-27 22:07:19,136 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-27 22:07:19,149 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-27 22:07:19,161 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-27 22:07:19,173 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-27 22:07:19,185 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-27 22:07:19,197 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-27 22:07:19,209 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-27 22:07:19,221 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-27 22:07:19,232 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-27 22:07:19,245 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-27 22:07:19,258 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-27 22:07:19,270 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-27 22:07:19,294 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-27 22:07:19,307 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-27 22:07:19,321 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-27 22:07:19,334 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-27 22:07:19,346 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-27 22:07:19,358 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-27 22:07:19,366 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-11-27 22:07:19,367 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-27 22:07:19,367 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-27 22:07:19,368 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-27 22:07:19,368 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-27 22:07:19,368 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-27 22:07:19,369 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-27 22:07:19,369 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-27 22:07:19,369 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-27 22:07:19,370 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-11-27 22:07:19,370 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-27 22:07:19,370 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-27 22:07:19,371 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-27 22:07:19,372 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-27 22:07:19,372 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-27 22:07:19,372 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-27 22:07:19,373 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-27 22:07:19,373 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-27 22:07:19,374 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-27 22:07:19,375 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-27 22:07:19,375 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-27 22:07:19,375 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-27 22:07:19,375 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-27 22:07:19,376 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-27 22:07:19,376 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-27 22:07:19,376 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-27 22:07:19,376 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-27 22:07:19,377 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-27 22:07:19,377 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-27 22:07:19,377 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-27 22:07:19,377 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-27 22:07:19,378 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-27 22:07:19,378 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-27 22:07:19,381 [salt.utils.extmods][INFO    ][21041] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-27 22:07:19,390 [salt.utils.extmods][INFO    ][21041] Syncing sdb for environment 'base'
2017-11-27 22:07:19,390 [salt.utils.extmods][INFO    ][21041] Loading cache from salt://_sdb, for base)
2017-11-27 22:07:19,391 [salt.fileclient  ][INFO    ][21041] Caching directory '_sdb/' for environment 'base'
2017-11-27 22:07:19,434 [salt.utils.extmods][INFO    ][21041] Syncing grains for environment 'base'
2017-11-27 22:07:19,434 [salt.utils.extmods][INFO    ][21041] Loading cache from salt://_grains, for base)
2017-11-27 22:07:19,434 [salt.fileclient  ][INFO    ][21041] Caching directory '_grains/' for environment 'base'
2017-11-27 22:07:19,485 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-27 22:07:19,497 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-27 22:07:19,509 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-27 22:07:19,522 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-27 22:07:19,536 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-27 22:07:19,551 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-27 22:07:19,562 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-27 22:07:19,574 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-27 22:07:19,587 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-27 22:07:19,599 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-27 22:07:19,611 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-27 22:07:19,623 [salt.fileclient  ][INFO    ][21041] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-27 22:07:19,634 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-27 22:07:19,635 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-27 22:07:19,635 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-27 22:07:19,636 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-27 22:07:19,636 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-27 22:07:19,637 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-27 22:07:19,637 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-27 22:07:19,638 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-27 22:07:19,638 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-27 22:07:19,639 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-27 22:07:19,639 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-27 22:07:19,640 [salt.utils.extmods][INFO    ][21041] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-27 22:07:19,642 [salt.utils.extmods][INFO    ][21041] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-27 22:07:19,650 [salt.utils.extmods][INFO    ][21041] Syncing renderers for environment 'base'
2017-11-27 22:07:19,651 [salt.utils.extmods][INFO    ][21041] Loading cache from salt://_renderers, for base)
2017-11-27 22:07:19,651 [salt.fileclient  ][INFO    ][21041] Caching directory '_renderers/' for environment 'base'
2017-11-27 22:07:19,688 [salt.utils.extmods][INFO    ][21041] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-27 22:07:19,691 [salt.utils.extmods][INFO    ][21041] Syncing returners for environment 'base'
2017-11-27 22:07:19,691 [salt.utils.extmods][INFO    ][21041] Loading cache from salt://_returners, for base)
2017-11-27 22:07:19,692 [salt.fileclient  ][INFO    ][21041] Caching directory '_returners/' for environment 'base'
2017-11-27 22:07:19,728 [salt.utils.extmods][INFO    ][21041] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-27 22:07:19,731 [salt.utils.extmods][INFO    ][21041] Syncing output for environment 'base'
2017-11-27 22:07:19,731 [salt.utils.extmods][INFO    ][21041] Loading cache from salt://_output, for base)
2017-11-27 22:07:19,731 [salt.fileclient  ][INFO    ][21041] Caching directory '_output/' for environment 'base'
2017-11-27 22:07:19,769 [salt.utils.extmods][INFO    ][21041] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-27 22:07:19,772 [salt.utils.extmods][INFO    ][21041] Syncing utils for environment 'base'
2017-11-27 22:07:19,772 [salt.utils.extmods][INFO    ][21041] Loading cache from salt://_utils, for base)
2017-11-27 22:07:19,772 [salt.fileclient  ][INFO    ][21041] Caching directory '_utils/' for environment 'base'
2017-11-27 22:07:19,812 [salt.utils.extmods][INFO    ][21041] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-27 22:07:19,815 [salt.utils.extmods][INFO    ][21041] Syncing log_handlers for environment 'base'
2017-11-27 22:07:19,815 [salt.utils.extmods][INFO    ][21041] Loading cache from salt://_log_handlers, for base)
2017-11-27 22:07:19,815 [salt.fileclient  ][INFO    ][21041] Caching directory '_log_handlers/' for environment 'base'
2017-11-27 22:07:19,858 [salt.utils.extmods][INFO    ][21041] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-27 22:07:19,861 [salt.utils.extmods][INFO    ][21041] Syncing proxy for environment 'base'
2017-11-27 22:07:19,862 [salt.utils.extmods][INFO    ][21041] Loading cache from salt://_proxy, for base)
2017-11-27 22:07:19,862 [salt.fileclient  ][INFO    ][21041] Caching directory '_proxy/' for environment 'base'
2017-11-27 22:07:19,901 [salt.utils.extmods][INFO    ][21041] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-27 22:07:19,904 [salt.utils.extmods][INFO    ][21041] Syncing engines for environment 'base'
2017-11-27 22:07:19,904 [salt.utils.extmods][INFO    ][21041] Loading cache from salt://_engines, for base)
2017-11-27 22:07:19,905 [salt.fileclient  ][INFO    ][21041] Caching directory '_engines/' for environment 'base'
2017-11-27 22:07:19,948 [salt.minion      ][INFO    ][21041] Returning information for job: 20171127220715201668
2017-11-27 22:07:20,761 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command state.sls with jid 20171127220720754934
2017-11-27 22:07:20,781 [salt.minion      ][INFO    ][21109] Starting a new job with PID 21109
2017-11-27 22:07:21,391 [salt.state       ][INFO    ][21109] Loading fresh modules for state activity
2017-11-27 22:07:21,431 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-27 22:07:21,463 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-27 22:07:21,500 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:21,656 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-27 22:07:21,670 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-27 22:07:21,703 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:21,776 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-27 22:07:21,798 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-27 22:07:21,865 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-27 22:07:21,889 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-27 22:07:21,904 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 22:07:21,923 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-27 22:07:21,933 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-27 22:07:21,971 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-27 22:07:21,992 [py.warnings      ][WARNING ][21109] /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-11-27 22:07:21,992 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'salt-minion --version' in directory '/root'
2017-11-27 22:07:22,344 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-27 22:07:22,369 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-27 22:07:22,387 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-27 22:07:22,403 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-27 22:07:22,459 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-27 22:07:22,478 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-27 22:07:22,516 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-27 22:07:22,571 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-27 22:07:22,649 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-27 22:07:22,680 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:22,766 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-27 22:07:22,795 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-27 22:07:22,881 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-27 22:07:22,911 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-27 22:07:22,931 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 22:07:22,955 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-27 22:07:22,976 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-27 22:07:23,014 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-27 22:07:23,043 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'salt-minion --version' in directory '/root'
2017-11-27 22:07:23,365 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-27 22:07:23,389 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-27 22:07:23,406 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-27 22:07:23,423 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-27 22:07:23,479 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-27 22:07:23,497 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-27 22:07:23,533 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-27 22:07:23,585 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-27 22:07:23,672 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-27 22:07:23,757 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:24,205 [salt.state       ][INFO    ][21109] Running state [salt-minion] at time 22:07:24.204928
2017-11-27 22:07:24,206 [salt.state       ][INFO    ][21109] Executing state pkg.installed for salt-minion
2017-11-27 22:07:24,207 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:07:24,524 [salt.state       ][INFO    ][21109] Package salt-minion is already installed
2017-11-27 22:07:24,524 [salt.state       ][INFO    ][21109] Completed state [salt-minion] at time 22:07:24.523870 duration_in_ms=318.942
2017-11-27 22:07:24,524 [salt.state       ][INFO    ][21109] Running state [salt_minion_dependency_packages] at time 22:07:24.524117
2017-11-27 22:07:24,524 [salt.state       ][INFO    ][21109] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-27 22:07:24,529 [salt.state       ][INFO    ][21109] All specified packages are already installed
2017-11-27 22:07:24,529 [salt.state       ][INFO    ][21109] Completed state [salt_minion_dependency_packages] at time 22:07:24.528989 duration_in_ms=4.873
2017-11-27 22:07:24,531 [salt.state       ][INFO    ][21109] Running state [/etc/salt/minion.d/minion.conf] at time 22:07:24.530642
2017-11-27 22:07:24,531 [salt.state       ][INFO    ][21109] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-27 22:07:24,556 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-27 22:07:24,623 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:24,687 [salt.fileclient  ][INFO    ][21109] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-27 22:07:24,742 [salt.state       ][INFO    ][21109] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-27 22:07:24,742 [salt.state       ][INFO    ][21109] Completed state [/etc/salt/minion.d/minion.conf] at time 22:07:24.741847 duration_in_ms=211.205
2017-11-27 22:07:24,742 [salt.state       ][INFO    ][21109] Running state [/etc/salt/minion.d/_virt.conf] at time 22:07:24.742209
2017-11-27 22:07:24,742 [salt.state       ][INFO    ][21109] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-27 22:07:24,743 [salt.state       ][INFO    ][21109] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-27 22:07:24,743 [salt.state       ][INFO    ][21109] Completed state [/etc/salt/minion.d/_virt.conf] at time 22:07:24.743213 duration_in_ms=1.004
2017-11-27 22:07:24,745 [salt.state       ][INFO    ][21109] Running state [salt-minion] at time 22:07:24.744808
2017-11-27 22:07:24,745 [salt.state       ][INFO    ][21109] Executing state service.running for salt-minion
2017-11-27 22:07:24,745 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-27 22:07:24,776 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-27 22:07:24,794 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-27 22:07:24,812 [salt.state       ][INFO    ][21109] The service salt-minion is already running
2017-11-27 22:07:24,812 [salt.state       ][INFO    ][21109] Completed state [salt-minion] at time 22:07:24.812373 duration_in_ms=67.563
2017-11-27 22:07:24,818 [salt.state       ][INFO    ][21109] Running state [/etc/salt/grains.d] at time 22:07:24.817941
2017-11-27 22:07:24,819 [salt.state       ][INFO    ][21109] Executing state file.directory for /etc/salt/grains.d
2017-11-27 22:07:24,820 [salt.state       ][INFO    ][21109] Directory /etc/salt/grains.d is in the correct state
2017-11-27 22:07:24,821 [salt.state       ][INFO    ][21109] Completed state [/etc/salt/grains.d] at time 22:07:24.820803 duration_in_ms=2.862
2017-11-27 22:07:24,822 [salt.state       ][INFO    ][21109] Running state [/etc/salt/grains] at time 22:07:24.822299
2017-11-27 22:07:24,823 [salt.state       ][INFO    ][21109] Executing state file.managed for /etc/salt/grains
2017-11-27 22:07:24,824 [salt.state       ][INFO    ][21109] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-27 22:07:24,824 [salt.state       ][INFO    ][21109] Completed state [/etc/salt/grains] at time 22:07:24.823935 duration_in_ms=1.636
2017-11-27 22:07:24,825 [salt.state       ][INFO    ][21109] Running state [/etc/salt/grains.d/placeholder] at time 22:07:24.824732
2017-11-27 22:07:24,825 [salt.state       ][INFO    ][21109] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-27 22:07:24,827 [salt.state       ][INFO    ][21109] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-27 22:07:24,827 [salt.state       ][INFO    ][21109] Completed state [/etc/salt/grains.d/placeholder] at time 22:07:24.827312 duration_in_ms=2.581
2017-11-27 22:07:24,828 [salt.state       ][INFO    ][21109] Running state [/etc/salt/grains.d/sphinx] at time 22:07:24.827967
2017-11-27 22:07:24,828 [salt.state       ][INFO    ][21109] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-27 22:07:24,830 [salt.state       ][INFO    ][21109] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.142
               - 192.168.11.252
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-27 22:07:24,831 [salt.state       ][INFO    ][21109] Completed state [/etc/salt/grains.d/sphinx] at time 22:07:24.830714 duration_in_ms=2.746
2017-11-27 22:07:24,831 [salt.state       ][INFO    ][21109] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.831401
2017-11-27 22:07:24,832 [salt.state       ][INFO    ][21109] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:24,832 [salt.state       ][INFO    ][21109] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:24,832 [salt.state       ][INFO    ][21109] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.831891 duration_in_ms=0.49
2017-11-27 22:07:24,832 [salt.state       ][INFO    ][21109] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.832027
2017-11-27 22:07:24,832 [salt.state       ][INFO    ][21109] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:24,833 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-27 22:07:24,932 [salt.state       ][INFO    ][21109] {'pid': 21188, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-27 22:07:24,933 [salt.state       ][INFO    ][21109] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.933055 duration_in_ms=101.026
2017-11-27 22:07:24,935 [salt.state       ][INFO    ][21109] Running state [/etc/salt/grains.d/dns_records] at time 22:07:24.934176
2017-11-27 22:07:24,935 [salt.state       ][INFO    ][21109] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-27 22:07:24,937 [salt.state       ][INFO    ][21109] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-27 22:07:24,937 [salt.state       ][INFO    ][21109] Completed state [/etc/salt/grains.d/dns_records] at time 22:07:24.937072 duration_in_ms=2.896
2017-11-27 22:07:24,939 [salt.state       ][INFO    ][21109] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.938849
2017-11-27 22:07:24,939 [salt.state       ][INFO    ][21109] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:24,940 [salt.state       ][INFO    ][21109] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:24,940 [salt.state       ][INFO    ][21109] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.940156 duration_in_ms=1.306
2017-11-27 22:07:24,941 [salt.state       ][INFO    ][21109] Running state [/etc/salt/grains.d/salt] at time 22:07:24.940971
2017-11-27 22:07:24,941 [salt.state       ][INFO    ][21109] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-27 22:07:24,944 [salt.state       ][INFO    ][21109] File /etc/salt/grains.d/salt is in the correct state
2017-11-27 22:07:24,944 [salt.state       ][INFO    ][21109] Completed state [/etc/salt/grains.d/salt] at time 22:07:24.943802 duration_in_ms=2.832
2017-11-27 22:07:24,946 [salt.state       ][INFO    ][21109] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.946252
2017-11-27 22:07:24,946 [salt.state       ][INFO    ][21109] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:24,947 [salt.state       ][INFO    ][21109] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:24,947 [salt.state       ][INFO    ][21109] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:07:24.946829 duration_in_ms=0.576
2017-11-27 22:07:24,948 [salt.state       ][INFO    ][21109] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:07:24.948348
2017-11-27 22:07:24,949 [salt.state       ][INFO    ][21109] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-27 22:07:24,949 [salt.state       ][INFO    ][21109] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-27 22:07:24,949 [salt.state       ][INFO    ][21109] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:07:24.948932 duration_in_ms=0.584
2017-11-27 22:07:24,949 [salt.state       ][INFO    ][21109] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:07:24.949082
2017-11-27 22:07:24,949 [salt.state       ][INFO    ][21109] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-27 22:07:24,951 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-27 22:07:24,965 [salt.state       ][INFO    ][21109] {'pid': 21190, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-27 22:07:24,967 [salt.state       ][INFO    ][21109] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:07:24.967186 duration_in_ms=18.104
2017-11-27 22:07:24,969 [salt.state       ][INFO    ][21109] Running state [mine.update] at time 22:07:24.969292
2017-11-27 22:07:24,970 [salt.state       ][INFO    ][21109] Executing state module.wait for mine.update
2017-11-27 22:07:24,971 [salt.state       ][INFO    ][21109] No changes made for mine.update
2017-11-27 22:07:24,971 [salt.state       ][INFO    ][21109] Completed state [mine.update] at time 22:07:24.970925 duration_in_ms=1.633
2017-11-27 22:07:24,971 [salt.state       ][INFO    ][21109] Running state [mine.update] at time 22:07:24.971357
2017-11-27 22:07:24,972 [salt.state       ][INFO    ][21109] Executing state module.mod_watch for mine.update
2017-11-27 22:07:25,509 [salt.state       ][INFO    ][21109] {'ret': True}
2017-11-27 22:07:25,510 [salt.state       ][INFO    ][21109] Completed state [mine.update] at time 22:07:25.510181 duration_in_ms=538.825
2017-11-27 22:07:25,511 [salt.state       ][INFO    ][21109] Running state [ca-certificates] at time 22:07:25.510986
2017-11-27 22:07:25,511 [salt.state       ][INFO    ][21109] Executing state pkg.installed for ca-certificates
2017-11-27 22:07:25,523 [salt.state       ][INFO    ][21109] Package ca-certificates is already installed
2017-11-27 22:07:25,523 [salt.state       ][INFO    ][21109] Completed state [ca-certificates] at time 22:07:25.523299 duration_in_ms=12.314
2017-11-27 22:07:25,524 [salt.state       ][INFO    ][21109] Running state [update-ca-certificates] at time 22:07:25.523905
2017-11-27 22:07:25,524 [salt.state       ][INFO    ][21109] Executing state cmd.wait for update-ca-certificates
2017-11-27 22:07:25,524 [salt.state       ][INFO    ][21109] No changes made for update-ca-certificates
2017-11-27 22:07:25,524 [salt.state       ][INFO    ][21109] Completed state [update-ca-certificates] at time 22:07:25.524449 duration_in_ms=0.544
2017-11-27 22:07:25,525 [salt.state       ][INFO    ][21109] Running state [libvirt-dev] at time 22:07:25.524616
2017-11-27 22:07:25,525 [salt.state       ][INFO    ][21109] Executing state pkg.installed for libvirt-dev
2017-11-27 22:07:25,528 [salt.state       ][INFO    ][21109] Package libvirt-dev is already installed
2017-11-27 22:07:25,529 [salt.state       ][INFO    ][21109] Completed state [libvirt-dev] at time 22:07:25.528634 duration_in_ms=4.018
2017-11-27 22:07:25,529 [salt.state       ][INFO    ][21109] Running state [pkg-config] at time 22:07:25.528804
2017-11-27 22:07:25,529 [salt.state       ][INFO    ][21109] Executing state pkg.installed for pkg-config
2017-11-27 22:07:25,533 [salt.state       ][INFO    ][21109] Package pkg-config is already installed
2017-11-27 22:07:25,533 [salt.state       ][INFO    ][21109] Completed state [pkg-config] at time 22:07:25.533069 duration_in_ms=4.265
2017-11-27 22:07:25,533 [salt.state       ][INFO    ][21109] Running state [virtng.init] at time 22:07:25.533241
2017-11-27 22:07:25,533 [salt.state       ][INFO    ][21109] Executing state module.run for virtng.init
2017-11-27 22:07:25,595 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command ['git', '--version'] in directory '/root'
2017-11-27 22:07:25,713 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,748 [salt.state       ][INFO    ][21109] unless execution succeeded
2017-11-27 22:07:25,748 [salt.state       ][INFO    ][21109] Completed state [virtng.init] at time 22:07:25.747840 duration_in_ms=214.599
2017-11-27 22:07:25,748 [salt.state       ][INFO    ][21109] Running state [virt.set_autostart] at time 22:07:25.748118
2017-11-27 22:07:25,748 [salt.state       ][INFO    ][21109] Executing state module.run for virt.set_autostart
2017-11-27 22:07:25,756 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,792 [salt.state       ][INFO    ][21109] unless execution succeeded
2017-11-27 22:07:25,793 [salt.state       ][INFO    ][21109] Completed state [virt.set_autostart] at time 22:07:25.792609 duration_in_ms=44.49
2017-11-27 22:07:25,793 [salt.state       ][INFO    ][21109] Running state [virtng.init] at time 22:07:25.793151
2017-11-27 22:07:25,795 [salt.state       ][INFO    ][21109] Executing state module.run for virtng.init
2017-11-27 22:07:25,802 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,835 [salt.state       ][INFO    ][21109] unless execution succeeded
2017-11-27 22:07:25,835 [salt.state       ][INFO    ][21109] Completed state [virtng.init] at time 22:07:25.834969 duration_in_ms=41.817
2017-11-27 22:07:25,836 [salt.state       ][INFO    ][21109] Running state [virt.set_autostart] at time 22:07:25.835470
2017-11-27 22:07:25,836 [salt.state       ][INFO    ][21109] Executing state module.run for virt.set_autostart
2017-11-27 22:07:25,844 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,883 [salt.state       ][INFO    ][21109] unless execution succeeded
2017-11-27 22:07:25,884 [salt.state       ][INFO    ][21109] Completed state [virt.set_autostart] at time 22:07:25.883642 duration_in_ms=48.172
2017-11-27 22:07:25,884 [salt.state       ][INFO    ][21109] Running state [virtng.init] at time 22:07:25.884128
2017-11-27 22:07:25,885 [salt.state       ][INFO    ][21109] Executing state module.run for virtng.init
2017-11-27 22:07:25,894 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,933 [salt.state       ][INFO    ][21109] unless execution succeeded
2017-11-27 22:07:25,934 [salt.state       ][INFO    ][21109] Completed state [virtng.init] at time 22:07:25.933821 duration_in_ms=49.4
2017-11-27 22:07:25,935 [salt.state       ][INFO    ][21109] Running state [virt.set_autostart] at time 22:07:25.934632
2017-11-27 22:07:25,935 [salt.state       ][INFO    ][21109] Executing state module.run for virt.set_autostart
2017-11-27 22:07:25,943 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:25,977 [salt.state       ][INFO    ][21109] unless execution succeeded
2017-11-27 22:07:25,977 [salt.state       ][INFO    ][21109] Completed state [virt.set_autostart] at time 22:07:25.977267 duration_in_ms=42.635
2017-11-27 22:07:25,979 [salt.state       ][INFO    ][21109] Running state [virtng.init] at time 22:07:25.978769
2017-11-27 22:07:25,979 [salt.state       ][INFO    ][21109] Executing state module.run for virtng.init
2017-11-27 22:07:25,987 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:26,022 [salt.state       ][INFO    ][21109] unless execution succeeded
2017-11-27 22:07:26,022 [salt.state       ][INFO    ][21109] Completed state [virtng.init] at time 22:07:26.022175 duration_in_ms=43.405
2017-11-27 22:07:26,023 [salt.state       ][INFO    ][21109] Running state [virt.set_autostart] at time 22:07:26.022663
2017-11-27 22:07:26,023 [salt.state       ][INFO    ][21109] Executing state module.run for virt.set_autostart
2017-11-27 22:07:26,029 [salt.loaded.int.module.cmdmod][INFO    ][21109] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:26,063 [salt.state       ][INFO    ][21109] unless execution succeeded
2017-11-27 22:07:26,064 [salt.state       ][INFO    ][21109] Completed state [virt.set_autostart] at time 22:07:26.064180 duration_in_ms=41.516
2017-11-27 22:07:26,072 [salt.minion      ][INFO    ][21109] Returning information for job: 20171127220720754934
2017-11-27 22:07:51,703 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command state.sls with jid 20171127220751693714
2017-11-27 22:07:51,730 [salt.minion      ][INFO    ][21251] Starting a new job with PID 21251
2017-11-27 22:07:54,434 [salt.state       ][INFO    ][21251] Loading fresh modules for state activity
2017-11-27 22:07:54,471 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-27 22:07:54,501 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-27 22:07:54,575 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:54,662 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-27 22:07:54,684 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-27 22:07:54,725 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:54,801 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-27 22:07:54,828 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-27 22:07:54,893 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-27 22:07:54,919 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-27 22:07:54,939 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 22:07:54,961 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-27 22:07:54,977 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-27 22:07:55,020 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-27 22:07:55,047 [py.warnings      ][WARNING ][21251] /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-11-27 22:07:55,048 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command 'salt-minion --version' in directory '/root'
2017-11-27 22:07:55,376 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-27 22:07:55,403 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-27 22:07:55,419 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-27 22:07:55,437 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-27 22:07:55,492 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-27 22:07:55,512 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-27 22:07:55,549 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-27 22:07:55,598 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-27 22:07:55,688 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-27 22:07:55,725 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:55,805 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-27 22:07:55,834 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-27 22:07:55,897 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-27 22:07:55,924 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-27 22:07:55,945 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 22:07:55,969 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-27 22:07:55,987 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-27 22:07:56,039 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-27 22:07:56,064 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command 'salt-minion --version' in directory '/root'
2017-11-27 22:07:56,393 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-27 22:07:56,424 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-27 22:07:56,444 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-27 22:07:56,463 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-27 22:07:56,516 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-27 22:07:56,542 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-27 22:07:56,581 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-27 22:07:56,633 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-27 22:07:56,722 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-27 22:07:56,806 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:57,207 [salt.state       ][INFO    ][21251] Running state [salt-minion] at time 22:07:57.206478
2017-11-27 22:07:57,207 [salt.state       ][INFO    ][21251] Executing state pkg.installed for salt-minion
2017-11-27 22:07:57,207 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:07:57,528 [salt.state       ][INFO    ][21251] Package salt-minion is already installed
2017-11-27 22:07:57,528 [salt.state       ][INFO    ][21251] Completed state [salt-minion] at time 22:07:57.527858 duration_in_ms=321.38
2017-11-27 22:07:57,528 [salt.state       ][INFO    ][21251] Running state [salt_minion_dependency_packages] at time 22:07:57.528127
2017-11-27 22:07:57,529 [salt.state       ][INFO    ][21251] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-27 22:07:57,533 [salt.state       ][INFO    ][21251] All specified packages are already installed
2017-11-27 22:07:57,533 [salt.state       ][INFO    ][21251] Completed state [salt_minion_dependency_packages] at time 22:07:57.533356 duration_in_ms=5.23
2017-11-27 22:07:57,535 [salt.state       ][INFO    ][21251] Running state [/etc/salt/minion.d/minion.conf] at time 22:07:57.535340
2017-11-27 22:07:57,536 [salt.state       ][INFO    ][21251] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-27 22:07:57,563 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-27 22:07:57,632 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-27 22:07:57,698 [salt.fileclient  ][INFO    ][21251] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-27 22:07:57,755 [salt.state       ][INFO    ][21251] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-27 22:07:57,755 [salt.state       ][INFO    ][21251] Completed state [/etc/salt/minion.d/minion.conf] at time 22:07:57.754893 duration_in_ms=219.553
2017-11-27 22:07:57,755 [salt.state       ][INFO    ][21251] Running state [/etc/salt/minion.d/_virt.conf] at time 22:07:57.755279
2017-11-27 22:07:57,756 [salt.state       ][INFO    ][21251] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-27 22:07:57,756 [salt.state       ][INFO    ][21251] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-27 22:07:57,756 [salt.state       ][INFO    ][21251] Completed state [/etc/salt/minion.d/_virt.conf] at time 22:07:57.756298 duration_in_ms=1.019
2017-11-27 22:07:57,758 [salt.state       ][INFO    ][21251] Running state [salt-minion] at time 22:07:57.757933
2017-11-27 22:07:57,758 [salt.state       ][INFO    ][21251] Executing state service.running for salt-minion
2017-11-27 22:07:57,759 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-27 22:07:57,791 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-27 22:07:57,811 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-27 22:07:57,828 [salt.state       ][INFO    ][21251] The service salt-minion is already running
2017-11-27 22:07:57,828 [salt.state       ][INFO    ][21251] Completed state [salt-minion] at time 22:07:57.828208 duration_in_ms=70.274
2017-11-27 22:07:57,832 [salt.state       ][INFO    ][21251] Running state [/etc/salt/grains.d] at time 22:07:57.831544
2017-11-27 22:07:57,832 [salt.state       ][INFO    ][21251] Executing state file.directory for /etc/salt/grains.d
2017-11-27 22:07:57,833 [salt.state       ][INFO    ][21251] Directory /etc/salt/grains.d is in the correct state
2017-11-27 22:07:57,833 [salt.state       ][INFO    ][21251] Completed state [/etc/salt/grains.d] at time 22:07:57.833092 duration_in_ms=1.548
2017-11-27 22:07:57,835 [salt.state       ][INFO    ][21251] Running state [/etc/salt/grains] at time 22:07:57.834813
2017-11-27 22:07:57,835 [salt.state       ][INFO    ][21251] Executing state file.managed for /etc/salt/grains
2017-11-27 22:07:57,836 [salt.state       ][INFO    ][21251] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-27 22:07:57,836 [salt.state       ][INFO    ][21251] Completed state [/etc/salt/grains] at time 22:07:57.835850 duration_in_ms=1.036
2017-11-27 22:07:57,836 [salt.state       ][INFO    ][21251] Running state [/etc/salt/grains.d/placeholder] at time 22:07:57.836351
2017-11-27 22:07:57,837 [salt.state       ][INFO    ][21251] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-27 22:07:57,837 [salt.state       ][INFO    ][21251] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-27 22:07:57,837 [salt.state       ][INFO    ][21251] Completed state [/etc/salt/grains.d/placeholder] at time 22:07:57.837332 duration_in_ms=0.981
2017-11-27 22:07:57,838 [salt.state       ][INFO    ][21251] Running state [/etc/salt/grains.d/sphinx] at time 22:07:57.838434
2017-11-27 22:07:57,839 [salt.state       ][INFO    ][21251] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-27 22:07:57,840 [salt.state       ][INFO    ][21251] File /etc/salt/grains.d/sphinx is in the correct state
2017-11-27 22:07:57,840 [salt.state       ][INFO    ][21251] Completed state [/etc/salt/grains.d/sphinx] at time 22:07:57.840001 duration_in_ms=1.567
2017-11-27 22:07:57,841 [salt.state       ][INFO    ][21251] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:07:57.841049
2017-11-27 22:07:57,841 [salt.state       ][INFO    ][21251] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:57,843 [salt.state       ][INFO    ][21251] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:57,843 [salt.state       ][INFO    ][21251] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:07:57.843020 duration_in_ms=1.972
2017-11-27 22:07:57,844 [salt.state       ][INFO    ][21251] Running state [/etc/salt/grains.d/dns_records] at time 22:07:57.843534
2017-11-27 22:07:57,844 [salt.state       ][INFO    ][21251] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-27 22:07:57,845 [salt.state       ][INFO    ][21251] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-27 22:07:57,845 [salt.state       ][INFO    ][21251] Completed state [/etc/salt/grains.d/dns_records] at time 22:07:57.845144 duration_in_ms=1.61
2017-11-27 22:07:57,847 [salt.state       ][INFO    ][21251] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:07:57.846491
2017-11-27 22:07:57,847 [salt.state       ][INFO    ][21251] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:57,847 [salt.state       ][INFO    ][21251] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:57,847 [salt.state       ][INFO    ][21251] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:07:57.847067 duration_in_ms=0.576
2017-11-27 22:07:57,847 [salt.state       ][INFO    ][21251] Running state [/etc/salt/grains.d/salt] at time 22:07:57.847406
2017-11-27 22:07:57,848 [salt.state       ][INFO    ][21251] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-27 22:07:57,848 [salt.state       ][INFO    ][21251] File /etc/salt/grains.d/salt is in the correct state
2017-11-27 22:07:57,848 [salt.state       ][INFO    ][21251] Completed state [/etc/salt/grains.d/salt] at time 22:07:57.848379 duration_in_ms=0.972
2017-11-27 22:07:57,849 [salt.state       ][INFO    ][21251] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:07:57.849070
2017-11-27 22:07:57,849 [salt.state       ][INFO    ][21251] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:57,850 [salt.state       ][INFO    ][21251] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-27 22:07:57,850 [salt.state       ][INFO    ][21251] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:07:57.849989 duration_in_ms=0.919
2017-11-27 22:07:57,852 [salt.state       ][INFO    ][21251] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:07:57.851519
2017-11-27 22:07:57,852 [salt.state       ][INFO    ][21251] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-27 22:07:57,852 [salt.state       ][INFO    ][21251] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-27 22:07:57,852 [salt.state       ][INFO    ][21251] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:07:57.852117 duration_in_ms=0.597
2017-11-27 22:07:57,853 [salt.state       ][INFO    ][21251] Running state [mine.update] at time 22:07:57.852626
2017-11-27 22:07:57,853 [salt.state       ][INFO    ][21251] Executing state module.wait for mine.update
2017-11-27 22:07:57,853 [salt.state       ][INFO    ][21251] No changes made for mine.update
2017-11-27 22:07:57,853 [salt.state       ][INFO    ][21251] Completed state [mine.update] at time 22:07:57.853145 duration_in_ms=0.52
2017-11-27 22:07:57,853 [salt.state       ][INFO    ][21251] Running state [ca-certificates] at time 22:07:57.853315
2017-11-27 22:07:57,854 [salt.state       ][INFO    ][21251] Executing state pkg.installed for ca-certificates
2017-11-27 22:07:57,859 [salt.state       ][INFO    ][21251] Package ca-certificates is already installed
2017-11-27 22:07:57,859 [salt.state       ][INFO    ][21251] Completed state [ca-certificates] at time 22:07:57.858914 duration_in_ms=5.599
2017-11-27 22:07:57,859 [salt.state       ][INFO    ][21251] Running state [update-ca-certificates] at time 22:07:57.859468
2017-11-27 22:07:57,860 [salt.state       ][INFO    ][21251] Executing state cmd.wait for update-ca-certificates
2017-11-27 22:07:57,861 [salt.state       ][INFO    ][21251] No changes made for update-ca-certificates
2017-11-27 22:07:57,861 [salt.state       ][INFO    ][21251] Completed state [update-ca-certificates] at time 22:07:57.860643 duration_in_ms=1.174
2017-11-27 22:07:57,861 [salt.state       ][INFO    ][21251] Running state [libvirt-dev] at time 22:07:57.860811
2017-11-27 22:07:57,861 [salt.state       ][INFO    ][21251] Executing state pkg.installed for libvirt-dev
2017-11-27 22:07:57,865 [salt.state       ][INFO    ][21251] Package libvirt-dev is already installed
2017-11-27 22:07:57,865 [salt.state       ][INFO    ][21251] Completed state [libvirt-dev] at time 22:07:57.865127 duration_in_ms=4.315
2017-11-27 22:07:57,865 [salt.state       ][INFO    ][21251] Running state [pkg-config] at time 22:07:57.865314
2017-11-27 22:07:57,866 [salt.state       ][INFO    ][21251] Executing state pkg.installed for pkg-config
2017-11-27 22:07:57,870 [salt.state       ][INFO    ][21251] Package pkg-config is already installed
2017-11-27 22:07:57,870 [salt.state       ][INFO    ][21251] Completed state [pkg-config] at time 22:07:57.870282 duration_in_ms=4.969
2017-11-27 22:07:57,871 [salt.state       ][INFO    ][21251] Running state [virtng.init] at time 22:07:57.870812
2017-11-27 22:07:57,871 [salt.state       ][INFO    ][21251] Executing state module.run for virtng.init
2017-11-27 22:07:57,917 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command ['git', '--version'] in directory '/root'
2017-11-27 22:07:58,020 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:58,053 [salt.state       ][INFO    ][21251] unless execution succeeded
2017-11-27 22:07:58,055 [salt.state       ][INFO    ][21251] Completed state [virtng.init] at time 22:07:58.054549 duration_in_ms=183.735
2017-11-27 22:07:58,055 [salt.state       ][INFO    ][21251] Running state [virt.set_autostart] at time 22:07:58.055098
2017-11-27 22:07:58,056 [salt.state       ][INFO    ][21251] Executing state module.run for virt.set_autostart
2017-11-27 22:07:58,063 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:58,103 [salt.state       ][INFO    ][21251] unless execution succeeded
2017-11-27 22:07:58,104 [salt.state       ][INFO    ][21251] Completed state [virt.set_autostart] at time 22:07:58.103531 duration_in_ms=48.433
2017-11-27 22:07:58,104 [salt.state       ][INFO    ][21251] Running state [virtng.init] at time 22:07:58.104131
2017-11-27 22:07:58,105 [salt.state       ][INFO    ][21251] Executing state module.run for virtng.init
2017-11-27 22:07:58,113 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:58,149 [salt.state       ][INFO    ][21251] unless execution succeeded
2017-11-27 22:07:58,150 [salt.state       ][INFO    ][21251] Completed state [virtng.init] at time 22:07:58.150238 duration_in_ms=46.105
2017-11-27 22:07:58,151 [salt.state       ][INFO    ][21251] Running state [virt.set_autostart] at time 22:07:58.150793
2017-11-27 22:07:58,151 [salt.state       ][INFO    ][21251] Executing state module.run for virt.set_autostart
2017-11-27 22:07:58,159 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:58,195 [salt.state       ][INFO    ][21251] unless execution succeeded
2017-11-27 22:07:58,195 [salt.state       ][INFO    ][21251] Completed state [virt.set_autostart] at time 22:07:58.195061 duration_in_ms=44.268
2017-11-27 22:07:58,196 [salt.state       ][INFO    ][21251] Running state [virtng.init] at time 22:07:58.195640
2017-11-27 22:07:58,196 [salt.state       ][INFO    ][21251] Executing state module.run for virtng.init
2017-11-27 22:07:58,205 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:58,236 [salt.state       ][INFO    ][21251] unless execution succeeded
2017-11-27 22:07:58,237 [salt.state       ][INFO    ][21251] Completed state [virtng.init] at time 22:07:58.236505 duration_in_ms=40.865
2017-11-27 22:07:58,237 [salt.state       ][INFO    ][21251] Running state [virt.set_autostart] at time 22:07:58.236754
2017-11-27 22:07:58,237 [salt.state       ][INFO    ][21251] Executing state module.run for virt.set_autostart
2017-11-27 22:07:58,244 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:58,275 [salt.state       ][INFO    ][21251] unless execution succeeded
2017-11-27 22:07:58,275 [salt.state       ][INFO    ][21251] Completed state [virt.set_autostart] at time 22:07:58.275322 duration_in_ms=38.569
2017-11-27 22:07:58,276 [salt.state       ][INFO    ][21251] Running state [virtng.init] at time 22:07:58.275558
2017-11-27 22:07:58,276 [salt.state       ][INFO    ][21251] Executing state module.run for virtng.init
2017-11-27 22:07:58,281 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:58,317 [salt.state       ][INFO    ][21251] unless execution succeeded
2017-11-27 22:07:58,317 [salt.state       ][INFO    ][21251] Completed state [virtng.init] at time 22:07:58.317019 duration_in_ms=41.459
2017-11-27 22:07:58,319 [salt.state       ][INFO    ][21251] Running state [virt.set_autostart] at time 22:07:58.319378
2017-11-27 22:07:58,320 [salt.state       ][INFO    ][21251] Executing state module.run for virt.set_autostart
2017-11-27 22:07:58,327 [salt.loaded.int.module.cmdmod][INFO    ][21251] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-27 22:07:58,369 [salt.state       ][INFO    ][21251] unless execution succeeded
2017-11-27 22:07:58,370 [salt.state       ][INFO    ][21251] Completed state [virt.set_autostart] at time 22:07:58.369428 duration_in_ms=50.05
2017-11-27 22:07:58,379 [salt.minion      ][INFO    ][21251] Returning information for job: 20171127220751693714
2017-11-27 22:08:19,104 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171127220819088456
2017-11-27 22:08:19,129 [salt.minion      ][INFO    ][21344] Starting a new job with PID 21344
2017-11-27 22:08:23,553 [salt.state       ][INFO    ][21344] Loading fresh modules for state activity
2017-11-27 22:08:23,593 [salt.state       ][ERROR   ][21344] No contents found in top file
2017-11-27 22:08:23,595 [salt.utils.extmods][INFO    ][21344] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-27 22:08:23,601 [salt.utils.extmods][INFO    ][21344] Syncing beacons for environment 'base'
2017-11-27 22:08:23,601 [salt.utils.extmods][INFO    ][21344] Loading cache from salt://_beacons, for base)
2017-11-27 22:08:23,601 [salt.fileclient  ][INFO    ][21344] Caching directory '_beacons/' for environment 'base'
2017-11-27 22:08:23,644 [salt.utils.extmods][INFO    ][21344] Syncing modules for environment 'base'
2017-11-27 22:08:23,645 [salt.utils.extmods][INFO    ][21344] Loading cache from salt://_modules, for base)
2017-11-27 22:08:23,645 [salt.fileclient  ][INFO    ][21344] Caching directory '_modules/' for environment 'base'
2017-11-27 22:08:23,707 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-11-27 22:08:23,729 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-27 22:08:23,740 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-27 22:08:23,754 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-27 22:08:23,764 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-27 22:08:23,778 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-27 22:08:24,085 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-27 22:08:24,115 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-27 22:08:24,138 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-27 22:08:24,165 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-27 22:08:24,185 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-27 22:08:24,205 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-27 22:08:24,228 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-27 22:08:24,254 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-27 22:08:24,278 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-27 22:08:24,318 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-27 22:08:24,357 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-27 22:08:24,375 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-27 22:08:24,389 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-27 22:08:24,407 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-27 22:08:24,425 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-27 22:08:24,442 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-27 22:08:24,465 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-27 22:08:24,486 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-27 22:08:24,501 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-27 22:08:24,523 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-27 22:08:24,539 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-27 22:08:24,554 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-27 22:08:24,568 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-27 22:08:24,608 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-27 22:08:24,629 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-27 22:08:24,649 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-27 22:08:24,698 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-27 22:08:24,715 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-27 22:08:24,723 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-27 22:08:24,724 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-11-27 22:08:24,725 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-27 22:08:24,725 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-27 22:08:24,725 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-27 22:08:24,726 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-27 22:08:24,727 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-27 22:08:24,727 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-27 22:08:24,728 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-27 22:08:24,728 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-27 22:08:24,728 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-27 22:08:24,729 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-27 22:08:24,729 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-27 22:08:24,729 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-27 22:08:24,730 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-27 22:08:24,730 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-27 22:08:24,731 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-27 22:08:24,732 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-27 22:08:24,732 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-27 22:08:24,733 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-27 22:08:24,733 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-27 22:08:24,734 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-27 22:08:24,734 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-27 22:08:24,735 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-27 22:08:24,735 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-27 22:08:24,736 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-27 22:08:24,736 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-27 22:08:24,737 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-27 22:08:24,737 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-27 22:08:24,737 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-27 22:08:24,738 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-27 22:08:24,738 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-27 22:08:24,738 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-27 22:08:24,738 [salt.utils.extmods][INFO    ][21344] 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-11-27 22:08:24,738 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-27 22:08:24,739 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-27 22:08:24,751 [salt.utils.extmods][INFO    ][21344] Syncing states for environment 'base'
2017-11-27 22:08:24,752 [salt.utils.extmods][INFO    ][21344] Loading cache from salt://_states, for base)
2017-11-27 22:08:24,752 [salt.fileclient  ][INFO    ][21344] Caching directory '_states/' for environment 'base'
2017-11-27 22:08:24,837 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-11-27 22:08:24,866 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-27 22:08:24,899 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-27 22:08:24,917 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-27 22:08:24,934 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-27 22:08:24,951 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-27 22:08:24,971 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-27 22:08:24,995 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-27 22:08:25,020 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-27 22:08:25,044 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-11-27 22:08:25,063 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-27 22:08:25,075 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-27 22:08:25,095 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-27 22:08:25,117 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-27 22:08:25,151 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-27 22:08:25,171 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-27 22:08:25,197 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-27 22:08:25,210 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-27 22:08:25,225 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-27 22:08:25,245 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-27 22:08:25,274 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-27 22:08:25,291 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-27 22:08:25,308 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-27 22:08:25,322 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-27 22:08:25,376 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-27 22:08:25,393 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-27 22:08:25,429 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-27 22:08:25,452 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-27 22:08:25,471 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-27 22:08:25,486 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-27 22:08:25,501 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-27 22:08:25,533 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-27 22:08:25,539 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-11-27 22:08:25,539 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-27 22:08:25,539 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-27 22:08:25,540 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-27 22:08:25,541 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-27 22:08:25,541 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-27 22:08:25,542 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-27 22:08:25,542 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-27 22:08:25,543 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-27 22:08:25,543 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-11-27 22:08:25,543 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-27 22:08:25,544 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-27 22:08:25,544 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-27 22:08:25,545 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-27 22:08:25,545 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-27 22:08:25,547 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-27 22:08:25,547 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-27 22:08:25,548 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-27 22:08:25,548 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-27 22:08:25,549 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-27 22:08:25,550 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-27 22:08:25,550 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-27 22:08:25,551 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-27 22:08:25,551 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-27 22:08:25,551 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-27 22:08:25,551 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-27 22:08:25,552 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-27 22:08:25,552 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-27 22:08:25,552 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-27 22:08:25,553 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-27 22:08:25,553 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-27 22:08:25,553 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-27 22:08:25,553 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-27 22:08:25,556 [salt.utils.extmods][INFO    ][21344] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-27 22:08:25,561 [salt.utils.extmods][INFO    ][21344] Syncing sdb for environment 'base'
2017-11-27 22:08:25,561 [salt.utils.extmods][INFO    ][21344] Loading cache from salt://_sdb, for base)
2017-11-27 22:08:25,562 [salt.fileclient  ][INFO    ][21344] Caching directory '_sdb/' for environment 'base'
2017-11-27 22:08:25,628 [salt.utils.extmods][INFO    ][21344] Syncing grains for environment 'base'
2017-11-27 22:08:25,628 [salt.utils.extmods][INFO    ][21344] Loading cache from salt://_grains, for base)
2017-11-27 22:08:25,628 [salt.fileclient  ][INFO    ][21344] Caching directory '_grains/' for environment 'base'
2017-11-27 22:08:25,695 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-27 22:08:25,709 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-27 22:08:25,726 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-27 22:08:25,753 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-27 22:08:25,775 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-27 22:08:25,791 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-27 22:08:25,811 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-27 22:08:25,824 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-27 22:08:25,837 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-27 22:08:25,855 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-27 22:08:25,874 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-27 22:08:25,891 [salt.fileclient  ][INFO    ][21344] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-27 22:08:25,897 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-27 22:08:25,898 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-27 22:08:25,898 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-27 22:08:25,898 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-27 22:08:25,898 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-27 22:08:25,899 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-27 22:08:25,899 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-27 22:08:25,899 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-27 22:08:25,900 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-27 22:08:25,903 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-27 22:08:25,903 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-27 22:08:25,903 [salt.utils.extmods][INFO    ][21344] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-27 22:08:25,906 [salt.utils.extmods][INFO    ][21344] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-27 22:08:25,909 [salt.utils.extmods][INFO    ][21344] Syncing renderers for environment 'base'
2017-11-27 22:08:25,909 [salt.utils.extmods][INFO    ][21344] Loading cache from salt://_renderers, for base)
2017-11-27 22:08:25,910 [salt.fileclient  ][INFO    ][21344] Caching directory '_renderers/' for environment 'base'
2017-11-27 22:08:25,982 [salt.utils.extmods][INFO    ][21344] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-27 22:08:25,986 [salt.utils.extmods][INFO    ][21344] Syncing returners for environment 'base'
2017-11-27 22:08:25,986 [salt.utils.extmods][INFO    ][21344] Loading cache from salt://_returners, for base)
2017-11-27 22:08:25,986 [salt.fileclient  ][INFO    ][21344] Caching directory '_returners/' for environment 'base'
2017-11-27 22:08:26,050 [salt.utils.extmods][INFO    ][21344] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-27 22:08:26,055 [salt.utils.extmods][INFO    ][21344] Syncing output for environment 'base'
2017-11-27 22:08:26,055 [salt.utils.extmods][INFO    ][21344] Loading cache from salt://_output, for base)
2017-11-27 22:08:26,055 [salt.fileclient  ][INFO    ][21344] Caching directory '_output/' for environment 'base'
2017-11-27 22:08:26,111 [salt.utils.extmods][INFO    ][21344] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-27 22:08:26,114 [salt.utils.extmods][INFO    ][21344] Syncing utils for environment 'base'
2017-11-27 22:08:26,114 [salt.utils.extmods][INFO    ][21344] Loading cache from salt://_utils, for base)
2017-11-27 22:08:26,114 [salt.fileclient  ][INFO    ][21344] Caching directory '_utils/' for environment 'base'
2017-11-27 22:08:26,216 [salt.utils.extmods][INFO    ][21344] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-27 22:08:26,220 [salt.utils.extmods][INFO    ][21344] Syncing log_handlers for environment 'base'
2017-11-27 22:08:26,220 [salt.utils.extmods][INFO    ][21344] Loading cache from salt://_log_handlers, for base)
2017-11-27 22:08:26,220 [salt.fileclient  ][INFO    ][21344] Caching directory '_log_handlers/' for environment 'base'
2017-11-27 22:08:26,261 [salt.utils.extmods][INFO    ][21344] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-27 22:08:26,265 [salt.utils.extmods][INFO    ][21344] Syncing proxy for environment 'base'
2017-11-27 22:08:26,265 [salt.utils.extmods][INFO    ][21344] Loading cache from salt://_proxy, for base)
2017-11-27 22:08:26,265 [salt.fileclient  ][INFO    ][21344] Caching directory '_proxy/' for environment 'base'
2017-11-27 22:08:26,319 [salt.utils.extmods][INFO    ][21344] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-27 22:08:26,323 [salt.utils.extmods][INFO    ][21344] Syncing engines for environment 'base'
2017-11-27 22:08:26,323 [salt.utils.extmods][INFO    ][21344] Loading cache from salt://_engines, for base)
2017-11-27 22:08:26,323 [salt.fileclient  ][INFO    ][21344] Caching directory '_engines/' for environment 'base'
2017-11-27 22:08:26,400 [salt.minion      ][INFO    ][21344] Returning information for job: 20171127220819088456
2017-11-27 22:15:22,120 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command test.ping with jid 20171127221522110662
2017-11-27 22:15:22,147 [salt.minion      ][INFO    ][21497] Starting a new job with PID 21497
2017-11-27 22:15:22,196 [salt.minion      ][INFO    ][21497] Returning information for job: 20171127221522110662
2017-11-27 22:17:05,555 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command state.sls with jid 20171127221705545982
2017-11-27 22:17:05,580 [salt.minion      ][INFO    ][21541] Starting a new job with PID 21541
2017-11-27 22:17:06,194 [salt.state       ][INFO    ][21541] Loading fresh modules for state activity
2017-11-27 22:17:06,618 [salt.fileclient  ][INFO    ][21541] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-27 22:17:06,660 [salt.fileclient  ][INFO    ][21541] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-27 22:17:06,716 [salt.fileclient  ][INFO    ][21541] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 22:17:07,090 [salt.state       ][INFO    ][21541] Running state [lsof] at time 22:17:07.089788
2017-11-27 22:17:07,091 [salt.state       ][INFO    ][21541] Executing state pkg.installed for lsof
2017-11-27 22:17:07,091 [salt.loaded.int.module.cmdmod][INFO    ][21541] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:17:07,388 [salt.state       ][INFO    ][21541] Package lsof is already installed
2017-11-27 22:17:07,388 [salt.state       ][INFO    ][21541] Completed state [lsof] at time 22:17:07.388036 duration_in_ms=298.248
2017-11-27 22:17:07,388 [salt.state       ][INFO    ][21541] Running state [keepalived] at time 22:17:07.388266
2017-11-27 22:17:07,388 [salt.state       ][INFO    ][21541] Executing state pkg.installed for keepalived
2017-11-27 22:17:07,410 [salt.loaded.int.module.cmdmod][INFO    ][21541] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-27 22:17:09,519 [salt.loaded.int.module.cmdmod][INFO    ][21541] 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-11-27 22:17:13,835 [salt.loaded.int.module.cmdmod][INFO    ][21541] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:17:13,888 [salt.state       ][INFO    ][21541] 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-11-27 22:17:13,900 [salt.state       ][INFO    ][21541] Loading fresh modules for state activity
2017-11-27 22:17:13,917 [salt.state       ][INFO    ][21541] Completed state [keepalived] at time 22:17:13.917350 duration_in_ms=6529.083
2017-11-27 22:17:13,920 [salt.state       ][INFO    ][21541] Running state [/etc/keepalived/keepalived.conf] at time 22:17:13.919888
2017-11-27 22:17:13,920 [salt.state       ][INFO    ][21541] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-27 22:17:13,951 [salt.fileclient  ][INFO    ][21541] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-27 22:17:14,007 [salt.fileclient  ][INFO    ][21541] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 22:17:14,023 [salt.state       ][INFO    ][21541] File changed:
New file
2017-11-27 22:17:14,023 [salt.state       ][INFO    ][21541] Completed state [/etc/keepalived/keepalived.conf] at time 22:17:14.023128 duration_in_ms=103.24
2017-11-27 22:17:14,117 [salt.state       ][INFO    ][21541] Running state [keepalived] at time 22:17:14.116540
2017-11-27 22:17:14,117 [salt.state       ][INFO    ][21541] Executing state service.running for keepalived
2017-11-27 22:17:14,119 [salt.loaded.int.module.cmdmod][INFO    ][21541] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-27 22:17:14,140 [salt.loaded.int.module.cmdmod][INFO    ][21541] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:14,164 [salt.loaded.int.module.cmdmod][INFO    ][21541] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:14,188 [salt.loaded.int.module.cmdmod][INFO    ][21541] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:14,209 [salt.loaded.int.module.cmdmod][INFO    ][21541] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:14,269 [salt.loaded.int.module.cmdmod][INFO    ][21541] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:14,297 [salt.loaded.int.module.cmdmod][INFO    ][21541] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:14,320 [salt.loaded.int.module.cmdmod][INFO    ][21541] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-27 22:17:14,343 [salt.state       ][INFO    ][21541] {'keepalived': True}
2017-11-27 22:17:14,344 [salt.state       ][INFO    ][21541] Completed state [keepalived] at time 22:17:14.343526 duration_in_ms=226.985
2017-11-27 22:17:14,349 [salt.minion      ][INFO    ][21541] Returning information for job: 20171127221705545982
2017-11-27 22:17:40,056 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command pillar.get with jid 20171127221740049390
2017-11-27 22:17:40,084 [salt.minion      ][INFO    ][22962] Starting a new job with PID 22962
2017-11-27 22:17:40,093 [salt.minion      ][INFO    ][22962] Returning information for job: 20171127221740049390
2017-11-27 22:22:51,308 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command state.sls with jid 20171127222251300700
2017-11-27 22:22:51,333 [salt.minion      ][INFO    ][23044] Starting a new job with PID 23044
2017-11-27 22:22:53,944 [salt.state       ][INFO    ][23044] Loading fresh modules for state activity
2017-11-27 22:22:53,988 [salt.fileclient  ][INFO    ][23044] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-27 22:22:54,024 [salt.fileclient  ][INFO    ][23044] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-27 22:22:54,390 [salt.state       ][INFO    ][23044] Running state [attr] at time 22:22:54.390412
2017-11-27 22:22:54,391 [salt.state       ][INFO    ][23044] Executing state pkg.installed for attr
2017-11-27 22:22:54,391 [salt.loaded.int.module.cmdmod][INFO    ][23044] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:22:54,747 [salt.loaded.int.module.cmdmod][INFO    ][23044] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-27 22:22:56,883 [salt.loaded.int.module.cmdmod][INFO    ][23044] 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-11-27 22:22:58,764 [salt.loaded.int.module.cmdmod][INFO    ][23044] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:22:58,821 [salt.state       ][INFO    ][23044] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-27 22:22:58,839 [salt.state       ][INFO    ][23044] Loading fresh modules for state activity
2017-11-27 22:22:58,891 [salt.state       ][INFO    ][23044] Completed state [attr] at time 22:22:58.891069 duration_in_ms=4500.658
2017-11-27 22:22:58,900 [salt.state       ][INFO    ][23044] Running state [glusterfs-server] at time 22:22:58.900300
2017-11-27 22:22:58,901 [salt.state       ][INFO    ][23044] Executing state pkg.installed for glusterfs-server
2017-11-27 22:22:59,203 [salt.loaded.int.module.cmdmod][INFO    ][23044] 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-11-27 22:23:01,412 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command saltutil.find_job with jid 20171127222301397037
2017-11-27 22:23:01,437 [salt.minion      ][INFO    ][23873] Starting a new job with PID 23873
2017-11-27 22:23:01,456 [salt.minion      ][INFO    ][23873] Returning information for job: 20171127222301397037
2017-11-27 22:23:11,574 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command saltutil.find_job with jid 20171127222311559016
2017-11-27 22:23:11,589 [salt.minion      ][INFO    ][25387] Starting a new job with PID 25387
2017-11-27 22:23:11,606 [salt.minion      ][INFO    ][25387] Returning information for job: 20171127222311559016
2017-11-27 22:23:11,770 [salt.loaded.int.module.cmdmod][INFO    ][23044] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:23:11,828 [salt.state       ][INFO    ][23044] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'glusterfs-client' changed from 'absent' to '3.10.7-ubuntu1~xenial1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'glusterfs-common' changed from 'absent' to '3.10.7-ubuntu1~xenial1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'portmap' changed from 'absent' to '1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'
'nfs-client' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.10.7-ubuntu1~xenial1'

2017-11-27 22:23:11,852 [salt.state       ][INFO    ][23044] Loading fresh modules for state activity
2017-11-27 22:23:11,874 [salt.state       ][INFO    ][23044] Completed state [glusterfs-server] at time 22:23:11.873715 duration_in_ms=12973.414
2017-11-27 22:23:11,880 [salt.state       ][INFO    ][23044] Running state [bc] at time 22:23:11.880384
2017-11-27 22:23:11,881 [salt.state       ][INFO    ][23044] Executing state pkg.installed for bc
2017-11-27 22:23:12,236 [salt.loaded.int.module.cmdmod][INFO    ][23044] 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-11-27 22:23:14,307 [salt.loaded.int.module.cmdmod][INFO    ][23044] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:23:14,365 [salt.state       ][INFO    ][23044] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-27 22:23:14,375 [salt.state       ][INFO    ][23044] Loading fresh modules for state activity
2017-11-27 22:23:14,397 [salt.state       ][INFO    ][23044] Completed state [bc] at time 22:23:14.397292 duration_in_ms=2516.907
2017-11-27 22:23:14,508 [salt.state       ][INFO    ][23044] Running state [glusterfs-server] at time 22:23:14.508115
2017-11-27 22:23:14,508 [salt.state       ][INFO    ][23044] Executing state service.running for glusterfs-server
2017-11-27 22:23:14,511 [salt.loaded.int.module.cmdmod][INFO    ][23044] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-27 22:23:14,526 [salt.loaded.int.module.cmdmod][INFO    ][23044] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-27 22:23:14,541 [salt.loaded.int.module.cmdmod][INFO    ][23044] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-27 22:23:14,559 [salt.state       ][INFO    ][23044] The service glusterfs-server is already running
2017-11-27 22:23:14,559 [salt.state       ][INFO    ][23044] Completed state [glusterfs-server] at time 22:23:14.559138 duration_in_ms=51.024
2017-11-27 22:23:14,564 [salt.state       ][INFO    ][23044] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:23:14.563497
2017-11-27 22:23:14,564 [salt.state       ][INFO    ][23044] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-27 22:23:14,575 [salt.state       ][INFO    ][23044] File changed:
New file
2017-11-27 22:23:14,575 [salt.state       ][INFO    ][23044] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:23:14.574761 duration_in_ms=11.265
2017-11-27 22:23:14,575 [salt.state       ][INFO    ][23044] Running state [/srv/glusterfs/glance] at time 22:23:14.574964
2017-11-27 22:23:14,575 [salt.state       ][INFO    ][23044] Executing state file.directory for /srv/glusterfs/glance
2017-11-27 22:23:14,576 [salt.state       ][INFO    ][23044] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-27 22:23:14,576 [salt.state       ][INFO    ][23044] Completed state [/srv/glusterfs/glance] at time 22:23:14.575979 duration_in_ms=1.015
2017-11-27 22:23:14,576 [salt.state       ][INFO    ][23044] Running state [/srv/glusterfs/keystone-keys] at time 22:23:14.576155
2017-11-27 22:23:14,576 [salt.state       ][INFO    ][23044] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-27 22:23:14,577 [salt.state       ][INFO    ][23044] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-27 22:23:14,577 [salt.state       ][INFO    ][23044] Completed state [/srv/glusterfs/keystone-keys] at time 22:23:14.576957 duration_in_ms=0.802
2017-11-27 22:23:14,577 [salt.state       ][INFO    ][23044] Running state [/srv/glusterfs/nova_instances] at time 22:23:14.577130
2017-11-27 22:23:14,577 [salt.state       ][INFO    ][23044] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-27 22:23:14,579 [salt.state       ][INFO    ][23044] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-27 22:23:14,579 [salt.state       ][INFO    ][23044] Completed state [/srv/glusterfs/nova_instances] at time 22:23:14.578804 duration_in_ms=1.674
2017-11-27 22:23:14,579 [salt.state       ][INFO    ][23044] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:23:14.578992
2017-11-27 22:23:14,579 [salt.state       ][INFO    ][23044] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-27 22:23:14,580 [salt.state       ][INFO    ][23044] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-27 22:23:14,580 [salt.state       ][INFO    ][23044] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:23:14.579767 duration_in_ms=0.775
2017-11-27 22:23:14,581 [salt.minion      ][INFO    ][23044] Returning information for job: 20171127222251300700
2017-11-27 22:23:17,545 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command test.ping with jid 20171127222317535142
2017-11-27 22:23:17,567 [salt.minion      ][INFO    ][25829] Starting a new job with PID 25829
2017-11-27 22:23:17,613 [salt.minion      ][INFO    ][25829] Returning information for job: 20171127222317535142
2017-11-27 22:23:17,759 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command state.sls with jid 20171127222317749793
2017-11-27 22:23:17,779 [salt.minion      ][INFO    ][25834] Starting a new job with PID 25834
2017-11-27 22:23:19,985 [salt.state       ][INFO    ][25834] Loading fresh modules for state activity
2017-11-27 22:23:20,023 [salt.fileclient  ][INFO    ][25834] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-27 22:23:20,071 [salt.fileclient  ][INFO    ][25834] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-27 22:23:20,178 [salt.fileclient  ][INFO    ][25834] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-27 22:23:20,209 [salt.fileclient  ][INFO    ][25834] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-27 22:23:20,566 [salt.state       ][INFO    ][25834] Running state [attr] at time 22:23:20.565941
2017-11-27 22:23:20,566 [salt.state       ][INFO    ][25834] Executing state pkg.installed for attr
2017-11-27 22:23:20,567 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 22:23:20,895 [salt.state       ][INFO    ][25834] Package attr is already installed
2017-11-27 22:23:20,896 [salt.state       ][INFO    ][25834] Completed state [attr] at time 22:23:20.895977 duration_in_ms=330.036
2017-11-27 22:23:20,896 [salt.state       ][INFO    ][25834] Running state [glusterfs-server] at time 22:23:20.896238
2017-11-27 22:23:20,896 [salt.state       ][INFO    ][25834] Executing state pkg.installed for glusterfs-server
2017-11-27 22:23:20,901 [salt.state       ][INFO    ][25834] Package glusterfs-server is already installed
2017-11-27 22:23:20,901 [salt.state       ][INFO    ][25834] Completed state [glusterfs-server] at time 22:23:20.901266 duration_in_ms=5.028
2017-11-27 22:23:20,901 [salt.state       ][INFO    ][25834] Running state [bc] at time 22:23:20.901429
2017-11-27 22:23:20,902 [salt.state       ][INFO    ][25834] Executing state pkg.installed for bc
2017-11-27 22:23:20,906 [salt.state       ][INFO    ][25834] Package bc is already installed
2017-11-27 22:23:20,906 [salt.state       ][INFO    ][25834] Completed state [bc] at time 22:23:20.906017 duration_in_ms=4.588
2017-11-27 22:23:20,907 [salt.state       ][INFO    ][25834] Running state [glusterfs-server] at time 22:23:20.906958
2017-11-27 22:23:20,907 [salt.state       ][INFO    ][25834] Executing state service.running for glusterfs-server
2017-11-27 22:23:20,908 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-27 22:23:20,925 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-27 22:23:21,020 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-27 22:23:21,060 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-27 22:23:21,076 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-27 22:23:21,095 [salt.state       ][INFO    ][25834] The service glusterfs-server is already running
2017-11-27 22:23:21,096 [salt.state       ][INFO    ][25834] Completed state [glusterfs-server] at time 22:23:21.095447 duration_in_ms=188.487
2017-11-27 22:23:21,099 [salt.state       ][INFO    ][25834] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:23:21.099011
2017-11-27 22:23:21,099 [salt.state       ][INFO    ][25834] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-27 22:23:21,105 [salt.state       ][INFO    ][25834] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-27 22:23:21,105 [salt.state       ][INFO    ][25834] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:23:21.104987 duration_in_ms=5.975
2017-11-27 22:23:21,106 [salt.state       ][INFO    ][25834] Running state [/srv/glusterfs/glance] at time 22:23:21.105448
2017-11-27 22:23:21,106 [salt.state       ][INFO    ][25834] Executing state file.directory for /srv/glusterfs/glance
2017-11-27 22:23:21,107 [salt.state       ][INFO    ][25834] Directory /srv/glusterfs/glance is in the correct state
2017-11-27 22:23:21,108 [salt.state       ][INFO    ][25834] Completed state [/srv/glusterfs/glance] at time 22:23:21.107633 duration_in_ms=2.186
2017-11-27 22:23:21,108 [salt.state       ][INFO    ][25834] Running state [/srv/glusterfs/keystone-keys] at time 22:23:21.107976
2017-11-27 22:23:21,108 [salt.state       ][INFO    ][25834] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-27 22:23:21,109 [salt.state       ][INFO    ][25834] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-27 22:23:21,109 [salt.state       ][INFO    ][25834] Completed state [/srv/glusterfs/keystone-keys] at time 22:23:21.109317 duration_in_ms=1.341
2017-11-27 22:23:21,111 [salt.state       ][INFO    ][25834] Running state [/srv/glusterfs/nova_instances] at time 22:23:21.110770
2017-11-27 22:23:21,111 [salt.state       ][INFO    ][25834] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-27 22:23:21,111 [salt.state       ][INFO    ][25834] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-27 22:23:21,112 [salt.state       ][INFO    ][25834] Completed state [/srv/glusterfs/nova_instances] at time 22:23:21.111545 duration_in_ms=0.774
2017-11-27 22:23:21,112 [salt.state       ][INFO    ][25834] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:23:21.111744
2017-11-27 22:23:21,112 [salt.state       ][INFO    ][25834] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-27 22:23:21,112 [salt.state       ][INFO    ][25834] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-27 22:23:21,113 [salt.state       ][INFO    ][25834] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:23:21.112495 duration_in_ms=0.751
2017-11-27 22:23:21,182 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command ['git', '--version'] in directory '/root'
2017-11-27 22:23:21,335 [salt.state       ][INFO    ][25834] Running state [sleep 5] at time 22:23:21.334579
2017-11-27 22:23:21,335 [salt.state       ][INFO    ][25834] Executing state cmd.wait for sleep 5
2017-11-27 22:23:21,335 [salt.state       ][INFO    ][25834] No changes made for sleep 5
2017-11-27 22:23:21,335 [salt.state       ][INFO    ][25834] Completed state [sleep 5] at time 22:23:21.335299 duration_in_ms=0.721
2017-11-27 22:23:21,336 [salt.state       ][INFO    ][25834] Running state [192.168.10.143] at time 22:23:21.335889
2017-11-27 22:23:21,336 [salt.state       ][INFO    ][25834] Executing state glusterfs.peered for 192.168.10.143
2017-11-27 22:23:21,337 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:21,355 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:21,455 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:21,477 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:21,598 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:21,620 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:21,712 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:21,729 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:21,817 [salt.state       ][INFO    ][25834] {'new': {'192.168.10.143': []}, 'old': None}
2017-11-27 22:23:21,818 [salt.state       ][INFO    ][25834] Completed state [192.168.10.143] at time 22:23:21.817405 duration_in_ms=481.514
2017-11-27 22:23:21,825 [salt.state       ][INFO    ][25834] Running state [192.168.10.142] at time 22:23:21.824577
2017-11-27 22:23:21,825 [salt.state       ][INFO    ][25834] Executing state glusterfs.peered for 192.168.10.142
2017-11-27 22:23:21,827 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:21,848 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:21,935 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:21,957 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:22,043 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:22,065 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:22,147 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:22,163 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:22,242 [salt.state       ][INFO    ][25834] Peering with localhost is not needed
2017-11-27 22:23:22,243 [salt.state       ][INFO    ][25834] Completed state [192.168.10.142] at time 22:23:22.242796 duration_in_ms=418.219
2017-11-27 22:23:22,251 [salt.state       ][INFO    ][25834] Running state [192.168.10.141] at time 22:23:22.250805
2017-11-27 22:23:22,251 [salt.state       ][INFO    ][25834] Executing state glusterfs.peered for 192.168.10.141
2017-11-27 22:23:22,252 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:22,271 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:22,354 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:22,372 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:22,485 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:22,509 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:22,598 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:22,619 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:22,706 [salt.state       ][INFO    ][25834] {'new': {'192.168.10.143': [], '192.168.10.141': []}, 'old': {'192.168.10.143': []}}
2017-11-27 22:23:22,706 [salt.state       ][INFO    ][25834] Completed state [192.168.10.141] at time 22:23:22.706351 duration_in_ms=455.546
2017-11-27 22:23:22,709 [salt.state       ][INFO    ][25834] Running state [glance] at time 22:23:22.709012
2017-11-27 22:23:22,710 [salt.state       ][INFO    ][25834] Executing state glusterfs.created for glance
2017-11-27 22:23:22,711 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:22,731 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:22,819 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:22,839 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:22,979 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:23,000 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:25,293 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:25,323 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:25,437 [salt.state       ][INFO    ][25834] {'new': ['glance'], 'old': []}
2017-11-27 22:23:25,437 [salt.state       ][INFO    ][25834] Completed state [glance] at time 22:23:25.437160 duration_in_ms=2728.147
2017-11-27 22:23:25,450 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:25.449442
2017-11-27 22:23:25,451 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 22:23:25,451 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:25,548 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-27 22:23:25,727 [salt.state       ][INFO    ][25834] {'pid': 26097, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:25,728 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:25.728214 duration_in_ms=278.771
2017-11-27 22:23:25,729 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:23:25.729340
2017-11-27 22:23:25,731 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-27 22:23:25,732 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 22:23:25,837 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-11-27 22:23:26,023 [salt.state       ][INFO    ][25834] {'pid': 26136, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:26,024 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:23:26.023490 duration_in_ms=294.15
2017-11-27 22:23:26,025 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:23:26.024749
2017-11-27 22:23:26,027 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-27 22:23:26,028 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 22:23:26,135 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-11-27 22:23:26,316 [salt.state       ][INFO    ][25834] {'pid': 26173, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:26,317 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:23:26.316671 duration_in_ms=291.922
2017-11-27 22:23:26,323 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:26.322619
2017-11-27 22:23:26,323 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 22:23:26,324 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 22:23:26,426 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-11-27 22:23:26,609 [salt.state       ][INFO    ][25834] {'pid': 26210, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:26,612 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:26.612003 duration_in_ms=289.383
2017-11-27 22:23:26,613 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:26.613218
2017-11-27 22:23:26,615 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 22:23:26,616 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:26,718 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-27 22:23:26,909 [salt.state       ][INFO    ][25834] {'pid': 26247, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:26,913 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:26.909304 duration_in_ms=296.084
2017-11-27 22:23:26,916 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:23:26.915658
2017-11-27 22:23:26,916 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-27 22:23:26,917 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 22:23:27,019 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-27 22:23:27,200 [salt.state       ][INFO    ][25834] {'pid': 26284, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:27,201 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:23:27.200927 duration_in_ms=285.269
2017-11-27 22:23:27,208 [salt.state       ][INFO    ][25834] Running state [glance] at time 22:23:27.208076
2017-11-27 22:23:27,209 [salt.state       ][INFO    ][25834] Executing state glusterfs.started for glance
2017-11-27 22:23:27,212 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:27,232 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:27,330 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:27,349 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:27,454 [salt.state       ][INFO    ][25834] Volume glance is already started
2017-11-27 22:23:27,455 [salt.state       ][INFO    ][25834] Completed state [glance] at time 22:23:27.454924 duration_in_ms=246.847
2017-11-27 22:23:27,457 [salt.state       ][INFO    ][25834] Running state [keystone-keys] at time 22:23:27.457384
2017-11-27 22:23:27,459 [salt.state       ][INFO    ][25834] Executing state glusterfs.created for keystone-keys
2017-11-27 22:23:27,459 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:27,480 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:27,564 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:27,583 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:27,714 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:27,737 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:27,817 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command saltutil.find_job with jid 20171127222327802981
2017-11-27 22:23:27,840 [salt.minion      ][INFO    ][26370] Starting a new job with PID 26370
2017-11-27 22:23:27,868 [salt.minion      ][INFO    ][26370] Returning information for job: 20171127222327802981
2017-11-27 22:23:29,945 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:29,974 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:30,081 [salt.state       ][INFO    ][25834] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-11-27 22:23:30,082 [salt.state       ][INFO    ][25834] Completed state [keystone-keys] at time 22:23:30.081750 duration_in_ms=2624.366
2017-11-27 22:23:30,095 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:23:30.095047
2017-11-27 22:23:30,095 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-27 22:23:30,096 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 22:23:30,183 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-27 22:23:30,363 [salt.state       ][INFO    ][25834] {'pid': 26442, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:30,363 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:23:30.363211 duration_in_ms=268.162
2017-11-27 22:23:30,365 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:30.364623
2017-11-27 22:23:30,368 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 22:23:30,369 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:30,473 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-27 22:23:30,668 [salt.state       ][INFO    ][25834] {'pid': 26479, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:30,668 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:30.668256 duration_in_ms=303.632
2017-11-27 22:23:30,672 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:30.671657
2017-11-27 22:23:30,672 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 22:23:30,673 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 22:23:30,773 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-11-27 22:23:30,975 [salt.state       ][INFO    ][25834] {'pid': 26518, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:30,975 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:30.975368 duration_in_ms=303.71
2017-11-27 22:23:30,977 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:30.976720
2017-11-27 22:23:30,977 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 22:23:30,981 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:31,091 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-27 22:23:31,283 [salt.state       ][INFO    ][25834] {'pid': 26555, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:31,284 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:31.283604 duration_in_ms=306.883
2017-11-27 22:23:31,285 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:23:31.284993
2017-11-27 22:23:31,287 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-27 22:23:31,288 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 22:23:31,395 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-27 22:23:31,588 [salt.state       ][INFO    ][25834] {'pid': 26592, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:31,589 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:23:31.588935 duration_in_ms=303.941
2017-11-27 22:23:31,592 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:23:31.591498
2017-11-27 22:23:31,592 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-27 22:23:31,594 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 22:23:31,691 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-27 22:23:31,877 [salt.state       ][INFO    ][25834] {'pid': 26629, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:31,879 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:23:31.879114 duration_in_ms=287.616
2017-11-27 22:23:31,888 [salt.state       ][INFO    ][25834] Running state [keystone-keys] at time 22:23:31.888120
2017-11-27 22:23:31,888 [salt.state       ][INFO    ][25834] Executing state glusterfs.started for keystone-keys
2017-11-27 22:23:31,889 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:31,915 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:32,001 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:32,017 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:32,116 [salt.state       ][INFO    ][25834] Volume keystone-keys is already started
2017-11-27 22:23:32,117 [salt.state       ][INFO    ][25834] Completed state [keystone-keys] at time 22:23:32.116573 duration_in_ms=228.452
2017-11-27 22:23:32,120 [salt.state       ][INFO    ][25834] Running state [nova_instances] at time 22:23:32.119867
2017-11-27 22:23:32,120 [salt.state       ][INFO    ][25834] Executing state glusterfs.created for nova_instances
2017-11-27 22:23:32,121 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:32,140 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:32,228 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:32,249 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:32,392 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:32,411 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:34,621 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:34,651 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:34,755 [salt.state       ][INFO    ][25834] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-11-27 22:23:34,756 [salt.state       ][INFO    ][25834] Completed state [nova_instances] at time 22:23:34.755600 duration_in_ms=2635.732
2017-11-27 22:23:34,771 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:34.770598
2017-11-27 22:23:34,771 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 22:23:34,772 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:34,867 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-27 22:23:35,081 [salt.state       ][INFO    ][25834] {'pid': 26784, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:35,081 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:35.081133 duration_in_ms=310.533
2017-11-27 22:23:35,084 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 22:23:35.083590
2017-11-27 22:23:35,084 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-11-27 22:23:35,085 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 22:23:35,183 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-27 22:23:35,391 [salt.state       ][INFO    ][25834] {'pid': 26823, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:35,391 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 22:23:35.391259 duration_in_ms=307.669
2017-11-27 22:23:35,393 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 22:23:35.392442
2017-11-27 22:23:35,393 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-11-27 22:23:35,395 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 22:23:35,499 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'True'' in directory '/root'
2017-11-27 22:23:35,705 [salt.state       ][INFO    ][25834] {'pid': 26860, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:35,705 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 22:23:35.705014 duration_in_ms=312.571
2017-11-27 22:23:35,708 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:35.707661
2017-11-27 22:23:35,708 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 22:23:35,709 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 22:23:35,812 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-11-27 22:23:36,018 [salt.state       ][INFO    ][25834] {'pid': 26897, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:36,019 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:36.018786 duration_in_ms=311.124
2017-11-27 22:23:36,020 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 22:23:36.020115
2017-11-27 22:23:36,021 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-11-27 22:23:36,025 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 22:23:36,131 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'True'' in directory '/root'
2017-11-27 22:23:36,333 [salt.state       ][INFO    ][25834] {'pid': 26934, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:36,335 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 22:23:36.334965 duration_in_ms=314.85
2017-11-27 22:23:36,337 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:36.336597
2017-11-27 22:23:36,337 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 22:23:36,340 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:36,443 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-27 22:23:36,625 [salt.state       ][INFO    ][25834] {'pid': 26971, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:36,627 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:36.626624 duration_in_ms=290.026
2017-11-27 22:23:36,633 [salt.state       ][INFO    ][25834] Running state [nova_instances] at time 22:23:36.632790
2017-11-27 22:23:36,633 [salt.state       ][INFO    ][25834] Executing state glusterfs.started for nova_instances
2017-11-27 22:23:36,635 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:36,656 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:36,747 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:36,764 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:36,870 [salt.state       ][INFO    ][25834] Volume nova_instances is already started
2017-11-27 22:23:36,871 [salt.state       ][INFO    ][25834] Completed state [nova_instances] at time 22:23:36.870571 duration_in_ms=237.781
2017-11-27 22:23:36,873 [salt.state       ][INFO    ][25834] Running state [keystone-credential-keys] at time 22:23:36.872669
2017-11-27 22:23:36,873 [salt.state       ][INFO    ][25834] Executing state glusterfs.created for keystone-credential-keys
2017-11-27 22:23:36,876 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:36,897 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:36,981 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:37,000 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:37,157 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:37,187 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:38,002 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command saltutil.find_job with jid 20171127222337992539
2017-11-27 22:23:38,026 [salt.minion      ][INFO    ][27069] Starting a new job with PID 27069
2017-11-27 22:23:38,047 [salt.minion      ][INFO    ][27069] Returning information for job: 20171127222337992539
2017-11-27 22:23:39,397 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:39,425 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:39,531 [salt.state       ][INFO    ][25834] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-11-27 22:23:39,532 [salt.state       ][INFO    ][25834] Completed state [keystone-credential-keys] at time 22:23:39.531565 duration_in_ms=2658.894
2017-11-27 22:23:39,545 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:23:39.545228
2017-11-27 22:23:39,546 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-27 22:23:39,547 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 22:23:39,641 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-27 22:23:39,856 [salt.state       ][INFO    ][25834] {'pid': 27134, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:39,857 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:23:39.856447 duration_in_ms=311.217
2017-11-27 22:23:39,861 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:39.861033
2017-11-27 22:23:39,864 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 22:23:39,867 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 22:23:39,976 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'' in directory '/root'
2017-11-27 22:23:40,179 [salt.state       ][INFO    ][25834] {'pid': 27171, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:40,180 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:23:40.179418 duration_in_ms=318.385
2017-11-27 22:23:40,181 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:40.180672
2017-11-27 22:23:40,181 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 22:23:40,184 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:40,283 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-27 22:23:40,485 [salt.state       ][INFO    ][25834] {'pid': 27208, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:40,488 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:23:40.487483 duration_in_ms=306.517
2017-11-27 22:23:40,489 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:23:40.488786
2017-11-27 22:23:40,489 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-27 22:23:40,492 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 22:23:40,599 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-27 22:23:40,824 [salt.state       ][INFO    ][25834] {'pid': 27247, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:40,824 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:23:40.824100 duration_in_ms=335.313
2017-11-27 22:23:40,827 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:40.827010
2017-11-27 22:23:40,828 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 22:23:40,829 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 22:23:40,936 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-27 22:23:41,144 [salt.state       ][INFO    ][25834] {'pid': 27285, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:41,144 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:23:41.144387 duration_in_ms=317.376
2017-11-27 22:23:41,147 [salt.state       ][INFO    ][25834] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:23:41.147291
2017-11-27 22:23:41,148 [salt.state       ][INFO    ][25834] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-27 22:23:41,148 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 22:23:41,251 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-27 22:23:41,461 [salt.state       ][INFO    ][25834] {'pid': 27322, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-27 22:23:41,464 [salt.state       ][INFO    ][25834] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:23:41.463908 duration_in_ms=316.616
2017-11-27 22:23:41,469 [salt.state       ][INFO    ][25834] Running state [keystone-credential-keys] at time 22:23:41.468523
2017-11-27 22:23:41,469 [salt.state       ][INFO    ][25834] Executing state glusterfs.started for keystone-credential-keys
2017-11-27 22:23:41,473 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:41,492 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:41,580 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --version' in directory '/root'
2017-11-27 22:23:41,600 [salt.loaded.int.module.cmdmod][INFO    ][25834] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 22:23:41,693 [salt.state       ][INFO    ][25834] Volume keystone-credential-keys is already started
2017-11-27 22:23:41,695 [salt.state       ][INFO    ][25834] Completed state [keystone-credential-keys] at time 22:23:41.694817 duration_in_ms=226.292
2017-11-27 22:23:41,700 [salt.minion      ][INFO    ][25834] Returning information for job: 20171127222317749793
2017-11-27 22:23:57,151 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command test.ping with jid 20171127222357144435
2017-11-27 22:23:57,179 [salt.minion      ][INFO    ][27378] Starting a new job with PID 27378
2017-11-27 22:23:57,226 [salt.minion      ][INFO    ][27378] Returning information for job: 20171127222357144435
2017-11-27 22:23:57,355 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command cmd.run with jid 20171127222357346019
2017-11-27 22:23:57,376 [salt.minion      ][INFO    ][27383] Starting a new job with PID 27383
2017-11-27 22:23:57,381 [salt.loaded.int.module.cmdmod][INFO    ][27383] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-27 22:23:57,575 [salt.minion      ][INFO    ][27383] Returning information for job: 20171127222357346019
2017-11-27 23:01:32,449 [salt.utils.schedule][INFO    ][20860] Running scheduled job: __mine_interval
2017-11-27 23:14:22,819 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command test.ping with jid 20171127231422809309
2017-11-27 23:14:22,845 [salt.minion      ][INFO    ][28057] Starting a new job with PID 28057
2017-11-27 23:14:22,901 [salt.minion      ][INFO    ][28057] Returning information for job: 20171127231422809309
2017-11-27 23:14:58,985 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command state.sls with jid 20171127231458974943
2017-11-27 23:14:59,017 [salt.minion      ][INFO    ][28065] Starting a new job with PID 28065
2017-11-27 23:14:59,608 [salt.state       ][INFO    ][28065] Loading fresh modules for state activity
2017-11-27 23:14:59,645 [salt.fileclient  ][INFO    ][28065] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-27 23:14:59,672 [salt.fileclient  ][INFO    ][28065] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-27 23:14:59,712 [salt.fileclient  ][INFO    ][28065] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 23:15:00,132 [salt.state       ][INFO    ][28065] Running state [lsof] at time 23:15:00.132292
2017-11-27 23:15:00,133 [salt.state       ][INFO    ][28065] Executing state pkg.installed for lsof
2017-11-27 23:15:00,133 [salt.loaded.int.module.cmdmod][INFO    ][28065] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 23:15:00,533 [salt.state       ][INFO    ][28065] Package lsof is already installed
2017-11-27 23:15:00,533 [salt.state       ][INFO    ][28065] Completed state [lsof] at time 23:15:00.533105 duration_in_ms=400.813
2017-11-27 23:15:00,534 [salt.state       ][INFO    ][28065] Running state [keepalived] at time 23:15:00.533981
2017-11-27 23:15:00,534 [salt.state       ][INFO    ][28065] Executing state pkg.installed for keepalived
2017-11-27 23:15:00,540 [salt.state       ][INFO    ][28065] Package keepalived is already installed
2017-11-27 23:15:00,540 [salt.state       ][INFO    ][28065] Completed state [keepalived] at time 23:15:00.539932 duration_in_ms=5.95
2017-11-27 23:15:00,542 [salt.state       ][INFO    ][28065] Running state [/etc/keepalived/keepalived.conf] at time 23:15:00.542239
2017-11-27 23:15:00,542 [salt.state       ][INFO    ][28065] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-27 23:15:00,573 [salt.fileclient  ][INFO    ][28065] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-27 23:15:00,627 [salt.fileclient  ][INFO    ][28065] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-27 23:15:00,639 [salt.state       ][INFO    ][28065] File /etc/keepalived/keepalived.conf is in the correct state
2017-11-27 23:15:00,640 [salt.state       ][INFO    ][28065] Completed state [/etc/keepalived/keepalived.conf] at time 23:15:00.639531 duration_in_ms=97.291
2017-11-27 23:15:00,642 [salt.state       ][INFO    ][28065] Running state [keepalived] at time 23:15:00.641441
2017-11-27 23:15:00,642 [salt.state       ][INFO    ][28065] Executing state service.running for keepalived
2017-11-27 23:15:00,643 [salt.loaded.int.module.cmdmod][INFO    ][28065] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-27 23:15:00,677 [salt.loaded.int.module.cmdmod][INFO    ][28065] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-27 23:15:00,692 [salt.loaded.int.module.cmdmod][INFO    ][28065] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-27 23:15:00,711 [salt.state       ][INFO    ][28065] The service keepalived is already running
2017-11-27 23:15:00,712 [salt.state       ][INFO    ][28065] Completed state [keepalived] at time 23:15:00.711839 duration_in_ms=70.396
2017-11-27 23:15:00,716 [salt.minion      ][INFO    ][28065] Returning information for job: 20171127231458974943
2017-11-27 23:15:05,140 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command pillar.get with jid 20171127231505133895
2017-11-27 23:15:05,169 [salt.minion      ][INFO    ][28089] Starting a new job with PID 28089
2017-11-27 23:15:05,175 [salt.minion      ][INFO    ][28089] Returning information for job: 20171127231505133895
2017-11-27 23:16:12,454 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command state.sls with jid 20171127231612445670
2017-11-27 23:16:12,477 [salt.minion      ][INFO    ][28095] Starting a new job with PID 28095
2017-11-27 23:16:15,089 [salt.state       ][INFO    ][28095] Loading fresh modules for state activity
2017-11-27 23:16:15,124 [salt.fileclient  ][INFO    ][28095] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-27 23:16:15,166 [salt.fileclient  ][INFO    ][28095] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-27 23:16:15,565 [salt.state       ][INFO    ][28095] Running state [attr] at time 23:16:15.565023
2017-11-27 23:16:15,566 [salt.state       ][INFO    ][28095] Executing state pkg.installed for attr
2017-11-27 23:16:15,567 [salt.loaded.int.module.cmdmod][INFO    ][28095] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 23:16:15,930 [salt.state       ][INFO    ][28095] Package attr is already installed
2017-11-27 23:16:15,930 [salt.state       ][INFO    ][28095] Completed state [attr] at time 23:16:15.930280 duration_in_ms=365.257
2017-11-27 23:16:15,931 [salt.state       ][INFO    ][28095] Running state [glusterfs-server] at time 23:16:15.930542
2017-11-27 23:16:15,931 [salt.state       ][INFO    ][28095] Executing state pkg.installed for glusterfs-server
2017-11-27 23:16:15,937 [salt.state       ][INFO    ][28095] Package glusterfs-server is already installed
2017-11-27 23:16:15,937 [salt.state       ][INFO    ][28095] Completed state [glusterfs-server] at time 23:16:15.936729 duration_in_ms=6.187
2017-11-27 23:16:15,937 [salt.state       ][INFO    ][28095] Running state [bc] at time 23:16:15.936908
2017-11-27 23:16:15,937 [salt.state       ][INFO    ][28095] Executing state pkg.installed for bc
2017-11-27 23:16:15,942 [salt.state       ][INFO    ][28095] Package bc is already installed
2017-11-27 23:16:15,942 [salt.state       ][INFO    ][28095] Completed state [bc] at time 23:16:15.942221 duration_in_ms=5.314
2017-11-27 23:16:15,943 [salt.state       ][INFO    ][28095] Running state [glusterfs-server] at time 23:16:15.943371
2017-11-27 23:16:15,944 [salt.state       ][INFO    ][28095] Executing state service.running for glusterfs-server
2017-11-27 23:16:15,944 [salt.loaded.int.module.cmdmod][INFO    ][28095] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-27 23:16:15,984 [salt.loaded.int.module.cmdmod][INFO    ][28095] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-27 23:16:16,004 [salt.loaded.int.module.cmdmod][INFO    ][28095] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-27 23:16:16,032 [salt.state       ][INFO    ][28095] The service glusterfs-server is already running
2017-11-27 23:16:16,033 [salt.state       ][INFO    ][28095] Completed state [glusterfs-server] at time 23:16:16.032812 duration_in_ms=89.439
2017-11-27 23:16:16,040 [salt.state       ][INFO    ][28095] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:16:16.039937
2017-11-27 23:16:16,041 [salt.state       ][INFO    ][28095] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-27 23:16:16,044 [salt.state       ][INFO    ][28095] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-27 23:16:16,045 [salt.state       ][INFO    ][28095] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:16:16.044546 duration_in_ms=4.61
2017-11-27 23:16:16,045 [salt.state       ][INFO    ][28095] Running state [/srv/glusterfs/glance] at time 23:16:16.044766
2017-11-27 23:16:16,045 [salt.state       ][INFO    ][28095] Executing state file.directory for /srv/glusterfs/glance
2017-11-27 23:16:16,047 [salt.state       ][INFO    ][28095] Directory /srv/glusterfs/glance is in the correct state
2017-11-27 23:16:16,048 [salt.state       ][INFO    ][28095] Completed state [/srv/glusterfs/glance] at time 23:16:16.047536 duration_in_ms=2.77
2017-11-27 23:16:16,048 [salt.state       ][INFO    ][28095] Running state [/srv/glusterfs/keystone-keys] at time 23:16:16.047727
2017-11-27 23:16:16,048 [salt.state       ][INFO    ][28095] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-27 23:16:16,048 [salt.state       ][INFO    ][28095] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-27 23:16:16,049 [salt.state       ][INFO    ][28095] Completed state [/srv/glusterfs/keystone-keys] at time 23:16:16.048512 duration_in_ms=0.784
2017-11-27 23:16:16,049 [salt.state       ][INFO    ][28095] Running state [/srv/glusterfs/nova_instances] at time 23:16:16.048696
2017-11-27 23:16:16,049 [salt.state       ][INFO    ][28095] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-27 23:16:16,049 [salt.state       ][INFO    ][28095] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-27 23:16:16,051 [salt.state       ][INFO    ][28095] Completed state [/srv/glusterfs/nova_instances] at time 23:16:16.049442 duration_in_ms=0.745
2017-11-27 23:16:16,051 [salt.state       ][INFO    ][28095] Running state [/srv/glusterfs/keystone-credential-keys] at time 23:16:16.051308
2017-11-27 23:16:16,052 [salt.state       ][INFO    ][28095] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-27 23:16:16,052 [salt.state       ][INFO    ][28095] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-27 23:16:16,052 [salt.state       ][INFO    ][28095] Completed state [/srv/glusterfs/keystone-credential-keys] at time 23:16:16.052444 duration_in_ms=1.136
2017-11-27 23:16:16,054 [salt.minion      ][INFO    ][28095] Returning information for job: 20171127231612445670
2017-11-27 23:16:17,299 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command test.ping with jid 20171127231617292006
2017-11-27 23:16:17,325 [salt.minion      ][INFO    ][28118] Starting a new job with PID 28118
2017-11-27 23:16:17,376 [salt.minion      ][INFO    ][28118] Returning information for job: 20171127231617292006
2017-11-27 23:16:17,516 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command state.sls with jid 20171127231617506133
2017-11-27 23:16:17,541 [salt.minion      ][INFO    ][28123] Starting a new job with PID 28123
2017-11-27 23:16:18,149 [salt.state       ][INFO    ][28123] Loading fresh modules for state activity
2017-11-27 23:16:18,185 [salt.fileclient  ][INFO    ][28123] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-27 23:16:18,244 [salt.fileclient  ][INFO    ][28123] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-27 23:16:18,357 [salt.fileclient  ][INFO    ][28123] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-27 23:16:18,392 [salt.fileclient  ][INFO    ][28123] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-27 23:16:18,802 [salt.state       ][INFO    ][28123] Running state [attr] at time 23:16:18.801927
2017-11-27 23:16:18,802 [salt.state       ][INFO    ][28123] Executing state pkg.installed for attr
2017-11-27 23:16:18,803 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-27 23:16:19,172 [salt.state       ][INFO    ][28123] Package attr is already installed
2017-11-27 23:16:19,172 [salt.state       ][INFO    ][28123] Completed state [attr] at time 23:16:19.172312 duration_in_ms=370.385
2017-11-27 23:16:19,173 [salt.state       ][INFO    ][28123] Running state [glusterfs-server] at time 23:16:19.172602
2017-11-27 23:16:19,173 [salt.state       ][INFO    ][28123] Executing state pkg.installed for glusterfs-server
2017-11-27 23:16:19,177 [salt.state       ][INFO    ][28123] Package glusterfs-server is already installed
2017-11-27 23:16:19,178 [salt.state       ][INFO    ][28123] Completed state [glusterfs-server] at time 23:16:19.177932 duration_in_ms=5.33
2017-11-27 23:16:19,178 [salt.state       ][INFO    ][28123] Running state [bc] at time 23:16:19.178134
2017-11-27 23:16:19,179 [salt.state       ][INFO    ][28123] Executing state pkg.installed for bc
2017-11-27 23:16:19,182 [salt.state       ][INFO    ][28123] Package bc is already installed
2017-11-27 23:16:19,183 [salt.state       ][INFO    ][28123] Completed state [bc] at time 23:16:19.182474 duration_in_ms=4.34
2017-11-27 23:16:19,184 [salt.state       ][INFO    ][28123] Running state [glusterfs-server] at time 23:16:19.183503
2017-11-27 23:16:19,184 [salt.state       ][INFO    ][28123] Executing state service.running for glusterfs-server
2017-11-27 23:16:19,184 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-27 23:16:19,220 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-27 23:16:19,234 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-27 23:16:19,259 [salt.state       ][INFO    ][28123] The service glusterfs-server is already running
2017-11-27 23:16:19,261 [salt.state       ][INFO    ][28123] Completed state [glusterfs-server] at time 23:16:19.260820 duration_in_ms=77.315
2017-11-27 23:16:19,268 [salt.state       ][INFO    ][28123] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:16:19.268461
2017-11-27 23:16:19,269 [salt.state       ][INFO    ][28123] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-27 23:16:19,273 [salt.state       ][INFO    ][28123] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-27 23:16:19,273 [salt.state       ][INFO    ][28123] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:16:19.273234 duration_in_ms=4.773
2017-11-27 23:16:19,275 [salt.state       ][INFO    ][28123] Running state [/srv/glusterfs/glance] at time 23:16:19.274635
2017-11-27 23:16:19,275 [salt.state       ][INFO    ][28123] Executing state file.directory for /srv/glusterfs/glance
2017-11-27 23:16:19,275 [salt.state       ][INFO    ][28123] Directory /srv/glusterfs/glance is in the correct state
2017-11-27 23:16:19,276 [salt.state       ][INFO    ][28123] Completed state [/srv/glusterfs/glance] at time 23:16:19.275585 duration_in_ms=0.949
2017-11-27 23:16:19,276 [salt.state       ][INFO    ][28123] Running state [/srv/glusterfs/keystone-keys] at time 23:16:19.275783
2017-11-27 23:16:19,276 [salt.state       ][INFO    ][28123] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-27 23:16:19,276 [salt.state       ][INFO    ][28123] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-27 23:16:19,277 [salt.state       ][INFO    ][28123] Completed state [/srv/glusterfs/keystone-keys] at time 23:16:19.276625 duration_in_ms=0.841
2017-11-27 23:16:19,277 [salt.state       ][INFO    ][28123] Running state [/srv/glusterfs/nova_instances] at time 23:16:19.276824
2017-11-27 23:16:19,277 [salt.state       ][INFO    ][28123] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-27 23:16:19,278 [salt.state       ][INFO    ][28123] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-27 23:16:19,278 [salt.state       ][INFO    ][28123] Completed state [/srv/glusterfs/nova_instances] at time 23:16:19.278234 duration_in_ms=1.41
2017-11-27 23:16:19,278 [salt.state       ][INFO    ][28123] Running state [/srv/glusterfs/keystone-credential-keys] at time 23:16:19.278450
2017-11-27 23:16:19,279 [salt.state       ][INFO    ][28123] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-27 23:16:19,279 [salt.state       ][INFO    ][28123] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-27 23:16:19,279 [salt.state       ][INFO    ][28123] Completed state [/srv/glusterfs/keystone-credential-keys] at time 23:16:19.279251 duration_in_ms=0.801
2017-11-27 23:16:19,343 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command ['git', '--version'] in directory '/root'
2017-11-27 23:16:19,461 [salt.state       ][INFO    ][28123] Running state [sleep 5] at time 23:16:19.461236
2017-11-27 23:16:19,462 [salt.state       ][INFO    ][28123] Executing state cmd.wait for sleep 5
2017-11-27 23:16:19,462 [salt.state       ][INFO    ][28123] No changes made for sleep 5
2017-11-27 23:16:19,463 [salt.state       ][INFO    ][28123] Completed state [sleep 5] at time 23:16:19.462545 duration_in_ms=1.309
2017-11-27 23:16:19,463 [salt.state       ][INFO    ][28123] Running state [192.168.10.143] at time 23:16:19.463150
2017-11-27 23:16:19,463 [salt.state       ][INFO    ][28123] Executing state glusterfs.peered for 192.168.10.143
2017-11-27 23:16:19,464 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:19,484 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:19,576 [salt.state       ][INFO    ][28123] Host 192.168.10.143 already peered
2017-11-27 23:16:19,577 [salt.state       ][INFO    ][28123] Completed state [192.168.10.143] at time 23:16:19.576919 duration_in_ms=113.767
2017-11-27 23:16:19,588 [salt.state       ][INFO    ][28123] Running state [192.168.10.142] at time 23:16:19.588226
2017-11-27 23:16:19,589 [salt.state       ][INFO    ][28123] Executing state glusterfs.peered for 192.168.10.142
2017-11-27 23:16:19,589 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:19,608 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:19,717 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:19,741 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:19,837 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:19,861 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:19,960 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:19,980 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:20,083 [salt.state       ][INFO    ][28123] Peering with localhost is not needed
2017-11-27 23:16:20,084 [salt.state       ][INFO    ][28123] Completed state [192.168.10.142] at time 23:16:20.083818 duration_in_ms=495.59
2017-11-27 23:16:20,095 [salt.state       ][INFO    ][28123] Running state [192.168.10.141] at time 23:16:20.094919
2017-11-27 23:16:20,095 [salt.state       ][INFO    ][28123] Executing state glusterfs.peered for 192.168.10.141
2017-11-27 23:16:20,096 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:20,113 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:20,207 [salt.state       ][INFO    ][28123] Host 192.168.10.141 already peered
2017-11-27 23:16:20,208 [salt.state       ][INFO    ][28123] Completed state [192.168.10.141] at time 23:16:20.207557 duration_in_ms=112.636
2017-11-27 23:16:20,211 [salt.state       ][INFO    ][28123] Running state [glance] at time 23:16:20.210984
2017-11-27 23:16:20,212 [salt.state       ][INFO    ][28123] Executing state glusterfs.created for glance
2017-11-27 23:16:20,213 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:20,231 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:20,329 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:20,349 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:20,456 [salt.state       ][INFO    ][28123] Volume glance already exists and is started.
2017-11-27 23:16:20,457 [salt.state       ][INFO    ][28123] Completed state [glance] at time 23:16:20.456523 duration_in_ms=245.538
2017-11-27 23:16:20,468 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:20.467629
2017-11-27 23:16:20,469 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 23:16:20,469 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:20,561 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:20,561 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:20.561041 duration_in_ms=93.411
2017-11-27 23:16:20,563 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 23:16:20.563005
2017-11-27 23:16:20,564 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-27 23:16:20,565 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 23:16:20,673 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:20,673 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 23:16:20.673076 duration_in_ms=110.071
2017-11-27 23:16:20,676 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 23:16:20.675978
2017-11-27 23:16:20,676 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-27 23:16:20,677 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 23:16:20,773 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:20,774 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 23:16:20.774320 duration_in_ms=98.343
2017-11-27 23:16:20,777 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:20.776712
2017-11-27 23:16:20,777 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 23:16:20,779 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 23:16:20,887 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:20,887 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:20.887324 duration_in_ms=110.61
2017-11-27 23:16:20,889 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:20.888516
2017-11-27 23:16:20,889 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 23:16:20,892 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:21,004 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:21,004 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:21.004206 duration_in_ms=115.688
2017-11-27 23:16:21,006 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 23:16:21.005521
2017-11-27 23:16:21,006 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-27 23:16:21,008 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 23:16:21,121 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:21,122 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 23:16:21.122032 duration_in_ms=116.512
2017-11-27 23:16:21,127 [salt.state       ][INFO    ][28123] Running state [glance] at time 23:16:21.126847
2017-11-27 23:16:21,128 [salt.state       ][INFO    ][28123] Executing state glusterfs.started for glance
2017-11-27 23:16:21,128 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:21,148 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:21,239 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:21,262 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:21,375 [salt.state       ][INFO    ][28123] Volume glance is already started
2017-11-27 23:16:21,376 [salt.state       ][INFO    ][28123] Completed state [glance] at time 23:16:21.375853 duration_in_ms=249.005
2017-11-27 23:16:21,380 [salt.state       ][INFO    ][28123] Running state [keystone-keys] at time 23:16:21.379552
2017-11-27 23:16:21,380 [salt.state       ][INFO    ][28123] Executing state glusterfs.created for keystone-keys
2017-11-27 23:16:21,381 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:21,400 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:21,501 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:21,521 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:21,627 [salt.state       ][INFO    ][28123] Volume keystone-keys already exists and is started.
2017-11-27 23:16:21,629 [salt.state       ][INFO    ][28123] Completed state [keystone-keys] at time 23:16:21.628427 duration_in_ms=248.873
2017-11-27 23:16:21,643 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 23:16:21.643249
2017-11-27 23:16:21,643 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-27 23:16:21,644 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 23:16:21,752 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:21,752 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 23:16:21.752331 duration_in_ms=109.08
2017-11-27 23:16:21,754 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:21.753631
2017-11-27 23:16:21,754 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 23:16:21,756 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:21,874 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:21,874 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:21.874085 duration_in_ms=120.452
2017-11-27 23:16:21,875 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:21.875321
2017-11-27 23:16:21,876 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 23:16:21,877 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 23:16:21,985 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:21,987 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:21.985173 duration_in_ms=109.85
2017-11-27 23:16:21,989 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:21.989392
2017-11-27 23:16:21,990 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 23:16:21,991 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:22,102 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:22,103 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:22.102633 duration_in_ms=113.239
2017-11-27 23:16:22,105 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 23:16:22.104480
2017-11-27 23:16:22,105 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-27 23:16:22,107 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 23:16:22,224 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:22,225 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 23:16:22.224753 duration_in_ms=120.273
2017-11-27 23:16:22,228 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 23:16:22.227932
2017-11-27 23:16:22,228 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-27 23:16:22,229 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 23:16:22,335 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:22,336 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 23:16:22.335552 duration_in_ms=107.62
2017-11-27 23:16:22,339 [salt.state       ][INFO    ][28123] Running state [keystone-keys] at time 23:16:22.339153
2017-11-27 23:16:22,340 [salt.state       ][INFO    ][28123] Executing state glusterfs.started for keystone-keys
2017-11-27 23:16:22,341 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:22,363 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:22,461 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:22,484 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:22,588 [salt.state       ][INFO    ][28123] Volume keystone-keys is already started
2017-11-27 23:16:22,589 [salt.state       ][INFO    ][28123] Completed state [keystone-keys] at time 23:16:22.588960 duration_in_ms=249.807
2017-11-27 23:16:22,593 [salt.state       ][INFO    ][28123] Running state [nova_instances] at time 23:16:22.592983
2017-11-27 23:16:22,594 [salt.state       ][INFO    ][28123] Executing state glusterfs.created for nova_instances
2017-11-27 23:16:22,595 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:22,615 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:22,713 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:22,735 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:22,856 [salt.state       ][INFO    ][28123] Volume nova_instances already exists and is started.
2017-11-27 23:16:22,856 [salt.state       ][INFO    ][28123] Completed state [nova_instances] at time 23:16:22.855893 duration_in_ms=262.909
2017-11-27 23:16:22,868 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:22.868017
2017-11-27 23:16:22,868 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 23:16:22,869 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:22,971 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:22,972 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:22.971749 duration_in_ms=103.731
2017-11-27 23:16:22,973 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 23:16:22.972844
2017-11-27 23:16:22,973 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-11-27 23:16:22,975 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 23:16:23,090 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:23,091 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 23:16:23.090506 duration_in_ms=117.661
2017-11-27 23:16:23,092 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 23:16:23.091984
2017-11-27 23:16:23,092 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-11-27 23:16:23,093 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 23:16:23,201 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:23,204 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 23:16:23.203489 duration_in_ms=111.505
2017-11-27 23:16:23,205 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:23.204663
2017-11-27 23:16:23,205 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 23:16:23,206 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 23:16:23,329 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:23,329 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:23.329084 duration_in_ms=124.421
2017-11-27 23:16:23,330 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 23:16:23.330207
2017-11-27 23:16:23,331 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-11-27 23:16:23,332 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 23:16:23,432 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:23,433 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 23:16:23.432587 duration_in_ms=102.381
2017-11-27 23:16:23,434 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:23.433935
2017-11-27 23:16:23,435 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 23:16:23,436 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:23,548 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:23,549 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:23.548841 duration_in_ms=114.905
2017-11-27 23:16:23,555 [salt.state       ][INFO    ][28123] Running state [nova_instances] at time 23:16:23.555052
2017-11-27 23:16:23,556 [salt.state       ][INFO    ][28123] Executing state glusterfs.started for nova_instances
2017-11-27 23:16:23,556 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:23,580 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:23,688 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:23,708 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:23,812 [salt.state       ][INFO    ][28123] Volume nova_instances is already started
2017-11-27 23:16:23,813 [salt.state       ][INFO    ][28123] Completed state [nova_instances] at time 23:16:23.812678 duration_in_ms=257.625
2017-11-27 23:16:23,817 [salt.state       ][INFO    ][28123] Running state [keystone-credential-keys] at time 23:16:23.817038
2017-11-27 23:16:23,819 [salt.state       ][INFO    ][28123] Executing state glusterfs.created for keystone-credential-keys
2017-11-27 23:16:23,820 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:23,840 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:23,935 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:23,952 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:24,062 [salt.state       ][INFO    ][28123] Volume keystone-credential-keys already exists and is started.
2017-11-27 23:16:24,063 [salt.state       ][INFO    ][28123] Completed state [keystone-credential-keys] at time 23:16:24.062695 duration_in_ms=245.656
2017-11-27 23:16:24,076 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 23:16:24.075480
2017-11-27 23:16:24,076 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-27 23:16:24,076 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-27 23:16:24,183 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:24,184 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 23:16:24.183675 duration_in_ms=108.194
2017-11-27 23:16:24,185 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:24.185122
2017-11-27 23:16:24,187 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-27 23:16:24,187 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-27 23:16:24,295 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:24,295 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 23:16:24.295380 duration_in_ms=110.257
2017-11-27 23:16:24,297 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:24.296644
2017-11-27 23:16:24,298 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-27 23:16:24,299 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:24,421 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:24,423 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:16:24.421423 duration_in_ms=124.78
2017-11-27 23:16:24,424 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 23:16:24.423583
2017-11-27 23:16:24,424 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-27 23:16:24,425 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-27 23:16:24,537 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:24,538 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 23:16:24.537666 duration_in_ms=114.082
2017-11-27 23:16:24,539 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:24.538695
2017-11-27 23:16:24,539 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-27 23:16:24,540 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-27 23:16:24,639 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:24,640 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:16:24.639859 duration_in_ms=101.164
2017-11-27 23:16:24,641 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 23:16:24.641032
2017-11-27 23:16:24,642 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-27 23:16:24,643 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-27 23:16:24,755 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-11-27 23:16:24,755 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 23:16:24.754981 duration_in_ms=113.949
2017-11-27 23:16:24,759 [salt.state       ][INFO    ][28123] Running state [keystone-credential-keys] at time 23:16:24.758970
2017-11-27 23:16:24,759 [salt.state       ][INFO    ][28123] Executing state glusterfs.started for keystone-credential-keys
2017-11-27 23:16:24,760 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:24,780 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:24,887 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-11-27 23:16:24,913 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-27 23:16:25,029 [salt.state       ][INFO    ][28123] Volume keystone-credential-keys is already started
2017-11-27 23:16:25,030 [salt.state       ][INFO    ][28123] Completed state [keystone-credential-keys] at time 23:16:25.030343 duration_in_ms=271.373
2017-11-27 23:16:25,036 [salt.minion      ][INFO    ][28123] Returning information for job: 20171127231617506133
2017-11-27 23:16:39,576 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command test.ping with jid 20171127231639566828
2017-11-27 23:16:39,601 [salt.minion      ][INFO    ][28634] Starting a new job with PID 28634
2017-11-27 23:16:39,654 [salt.minion      ][INFO    ][28634] Returning information for job: 20171127231639566828
2017-11-27 23:16:39,789 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command cmd.run with jid 20171127231639780167
2017-11-27 23:16:39,814 [salt.minion      ][INFO    ][28639] Starting a new job with PID 28639
2017-11-27 23:16:39,824 [salt.loaded.int.module.cmdmod][INFO    ][28639] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-27 23:16:40,039 [salt.minion      ][INFO    ][28639] Returning information for job: 20171127231639780167
2017-11-27 23:39:25,733 [salt.minion      ][INFO    ][20860] User sudo_ubuntu Executing command cp.push_dir with jid 20171127233925713756
2017-11-27 23:39:25,759 [salt.minion      ][INFO    ][28807] Starting a new job with PID 28807
