2017-10-25 14:52:11,673 [salt.cli.daemons ][WARNING ][2585] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-25 15:26:24,916 [salt.state       ][ERROR   ][3924] No contents found in top file
2017-10-25 15:29:54,839 [salt.utils.parsers][WARNING ][2585] Minion received a SIGTERM. Exiting.
2017-10-25 15:32:20,834 [salt.cli.daemons ][WARNING ][3227] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-25 15:35:08,083 [salt.loaded.int.module.cmdmod][ERROR   ][11079] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-10-25 15:35:08,083 [salt.loaded.int.module.cmdmod][ERROR   ][11079] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-10-25 15:35:08,083 [salt.loaded.int.module.cmdmod][ERROR   ][11079] retcode: 1
2017-10-25 15:35:08,084 [salt.state       ][ERROR   ][11079] {'pid': 15954, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-10-25 15:35:24,166 [py.warnings      ][WARNING ][16031] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-25 15:36:30,726 [salt.loaded.int.module.cmdmod][ERROR   ][16031] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-25 15:36:30,726 [salt.loaded.int.module.cmdmod][ERROR   ][16031] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-25 15:36:36,949 [salt.loaded.int.module.cmdmod][ERROR   ][16031] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-25 15:36:36,950 [salt.loaded.int.module.cmdmod][ERROR   ][16031] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-25 15:36:45,442 [salt.loaded.int.module.cmdmod][ERROR   ][16031] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-25 15:36:45,442 [salt.loaded.int.module.cmdmod][ERROR   ][16031] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-25 15:36:54,085 [salt.loaded.int.module.cmdmod][ERROR   ][16031] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-25 15:36:54,086 [salt.loaded.int.module.cmdmod][ERROR   ][16031] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-25 15:36:59,982 [salt.loaded.int.module.cmdmod][ERROR   ][16031] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-10-25 15:37:02,231 [salt.loaded.int.module.cmdmod][INFO    ][23327] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-25 15:37:02,236 [salt.loaded.int.module.cmdmod][INFO    ][23327] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-25 15:37:02,244 [salt.loaded.int.module.cmdmod][INFO    ][23327] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-10-25 15:37:02,250 [salt.utils.parsers][WARNING ][3227] Minion received a SIGTERM. Exiting.
2017-10-25 15:37:02,501 [salt.cli.daemons ][INFO    ][23414] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-10-25 15:37:02,998 [salt.minion      ][INFO    ][23414] Creating minion process manager
2017-10-25 15:37:02,998 [salt.cli.daemons ][WARNING ][23414] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-25 15:37:02,998 [salt.cli.daemons ][INFO    ][23414] The Salt Minion is starting up
2017-10-25 15:37:02,998 [salt.minion      ][INFO    ][23414] Minion is starting as user 'root'
2017-10-25 15:37:02,999 [salt.utils.event ][INFO    ][23414] Starting pull socket on /var/run/salt/minion/minion_event_0031115955_pull.ipc
2017-10-25 15:37:03,925 [salt.loaded.int.module.cmdmod][INFO    ][23414] Executing command ['date', '+%z'] in directory '/root'
2017-10-25 15:37:03,933 [salt.utils.schedule][INFO    ][23414] Updating job settings for scheduled job: __mine_interval
2017-10-25 15:37:03,935 [salt.minion      ][INFO    ][23414] Added mine.update to scheduler
2017-10-25 15:37:04,111 [salt.minion      ][INFO    ][23414] Minion is ready to receive requests!
2017-10-25 15:37:05,112 [salt.utils.schedule][INFO    ][23414] Running scheduled job: __mine_interval
2017-10-25 15:37:22,793 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171025153722786104
2017-10-25 15:37:22,809 [salt.minion      ][INFO    ][23552] Starting a new job with PID 23552
2017-10-25 15:37:25,266 [salt.state       ][INFO    ][23552] Loading fresh modules for state activity
2017-10-25 15:37:25,288 [salt.state       ][ERROR   ][23552] No contents found in top file
2017-10-25 15:37:25,294 [salt.utils.extmods][INFO    ][23552] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-25 15:37:25,297 [salt.utils.extmods][INFO    ][23552] Syncing beacons for environment 'base'
2017-10-25 15:37:25,297 [salt.utils.extmods][INFO    ][23552] Loading cache from salt://_beacons, for base)
2017-10-25 15:37:25,297 [salt.fileclient  ][INFO    ][23552] Caching directory '_beacons/' for environment 'base'
2017-10-25 15:37:25,318 [salt.utils.extmods][INFO    ][23552] Syncing modules for environment 'base'
2017-10-25 15:37:25,318 [salt.utils.extmods][INFO    ][23552] Loading cache from salt://_modules, for base)
2017-10-25 15:37:25,318 [salt.fileclient  ][INFO    ][23552] Caching directory '_modules/' for environment 'base'
2017-10-25 15:37:25,391 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-25 15:37:25,465 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-25 15:37:25,523 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-25 15:37:25,555 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-25 15:37:25,625 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-25 15:37:25,664 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-25 15:37:25,717 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-25 15:37:25,747 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-25 15:37:25,779 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-25 15:37:25,820 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-25 15:37:25,856 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-25 15:37:25,867 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-25 15:37:25,939 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-25 15:37:25,964 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-25 15:37:25,979 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-25 15:37:26,018 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-25 15:37:26,060 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-25 15:37:26,112 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-25 15:37:26,123 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-25 15:37:26,149 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-25 15:37:26,216 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-25 15:37:26,256 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-25 15:37:26,267 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-25 15:37:26,279 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-25 15:37:26,290 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-25 15:37:26,326 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-25 15:37:26,363 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-25 15:37:26,398 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-25 15:37:26,463 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-25 15:37:26,722 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-25 15:37:26,772 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-25 15:37:26,829 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-25 15:37:26,831 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-25 15:37:26,837 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-25 15:37:26,846 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-25 15:37:26,846 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-25 15:37:26,858 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-25 15:37:26,885 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-25 15:37:26,886 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-25 15:37:26,887 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-25 15:37:26,887 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-25 15:37:26,888 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-25 15:37:26,888 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-25 15:37:26,888 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-25 15:37:26,889 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-25 15:37:26,890 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-25 15:37:26,890 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-25 15:37:26,900 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-25 15:37:26,900 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-25 15:37:26,905 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-25 15:37:26,905 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-25 15:37:26,906 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-25 15:37:26,906 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-25 15:37:26,907 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-25 15:37:26,908 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-25 15:37:26,912 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-25 15:37:26,913 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-25 15:37:26,919 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-25 15:37:26,919 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-25 15:37:26,920 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-25 15:37:26,920 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-25 15:37:26,920 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-25 15:37:26,921 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-25 15:37:26,921 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-10-25 15:37:26,922 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-25 15:37:26,922 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-25 15:37:26,927 [salt.utils.extmods][INFO    ][23552] Syncing states for environment 'base'
2017-10-25 15:37:26,927 [salt.utils.extmods][INFO    ][23552] Loading cache from salt://_states, for base)
2017-10-25 15:37:26,927 [salt.fileclient  ][INFO    ][23552] Caching directory '_states/' for environment 'base'
2017-10-25 15:37:26,979 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-25 15:37:27,016 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-25 15:37:27,050 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-25 15:37:27,085 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-25 15:37:27,104 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-25 15:37:27,116 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-25 15:37:27,127 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-25 15:37:27,145 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-25 15:37:27,195 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-25 15:37:27,228 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-25 15:37:27,267 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-25 15:37:27,325 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-25 15:37:27,350 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-25 15:37:27,391 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-25 15:37:27,440 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-25 15:37:27,494 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-25 15:37:27,559 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-25 15:37:27,594 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-25 15:37:27,615 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-25 15:37:27,644 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-25 15:37:27,712 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-25 15:37:27,736 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-25 15:37:27,782 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-25 15:37:27,824 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-25 15:37:27,835 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-25 15:37:27,845 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-25 15:37:27,872 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-25 15:37:27,900 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-25 15:37:27,929 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-25 15:37:27,932 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-25 15:37:27,943 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-25 15:37:27,943 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-25 15:37:27,943 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-25 15:37:27,944 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-25 15:37:27,944 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-25 15:37:27,944 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-25 15:37:27,944 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-25 15:37:27,945 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-25 15:37:27,945 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-25 15:37:27,945 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-25 15:37:27,945 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-25 15:37:27,946 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-25 15:37:27,946 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-25 15:37:27,946 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-25 15:37:27,946 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-25 15:37:27,947 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-25 15:37:27,947 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-25 15:37:27,947 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-25 15:37:27,947 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-25 15:37:27,948 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-25 15:37:27,948 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-25 15:37:27,948 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-25 15:37:27,948 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-25 15:37:27,949 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-25 15:37:27,949 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-25 15:37:27,949 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-25 15:37:27,949 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-25 15:37:27,950 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-25 15:37:27,950 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-25 15:37:27,952 [salt.utils.extmods][INFO    ][23552] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-25 15:37:27,955 [salt.utils.extmods][INFO    ][23552] Syncing sdb for environment 'base'
2017-10-25 15:37:27,955 [salt.utils.extmods][INFO    ][23552] Loading cache from salt://_sdb, for base)
2017-10-25 15:37:27,955 [salt.fileclient  ][INFO    ][23552] Caching directory '_sdb/' for environment 'base'
2017-10-25 15:37:27,981 [salt.utils.extmods][INFO    ][23552] Syncing grains for environment 'base'
2017-10-25 15:37:27,981 [salt.utils.extmods][INFO    ][23552] Loading cache from salt://_grains, for base)
2017-10-25 15:37:27,981 [salt.fileclient  ][INFO    ][23552] Caching directory '_grains/' for environment 'base'
2017-10-25 15:37:28,041 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-25 15:37:28,067 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-25 15:37:28,115 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-25 15:37:28,144 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-25 15:37:28,193 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-25 15:37:28,239 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-25 15:37:28,321 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-25 15:37:28,455 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-25 15:37:28,493 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-25 15:37:28,505 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-25 15:37:28,563 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-25 15:37:28,606 [salt.fileclient  ][INFO    ][23552] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-25 15:37:28,609 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-25 15:37:28,642 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-25 15:37:28,648 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-25 15:37:28,659 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-25 15:37:28,693 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-25 15:37:28,714 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-25 15:37:28,725 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-25 15:37:28,762 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-25 15:37:28,767 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-25 15:37:28,796 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-25 15:37:28,839 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-25 15:37:28,855 [salt.utils.extmods][INFO    ][23552] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-25 15:37:28,901 [salt.utils.extmods][INFO    ][23552] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-25 15:37:28,904 [salt.utils.extmods][INFO    ][23552] Syncing renderers for environment 'base'
2017-10-25 15:37:28,904 [salt.utils.extmods][INFO    ][23552] Loading cache from salt://_renderers, for base)
2017-10-25 15:37:28,904 [salt.fileclient  ][INFO    ][23552] Caching directory '_renderers/' for environment 'base'
2017-10-25 15:37:28,943 [salt.utils.extmods][INFO    ][23552] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-25 15:37:28,946 [salt.utils.extmods][INFO    ][23552] Syncing returners for environment 'base'
2017-10-25 15:37:28,946 [salt.utils.extmods][INFO    ][23552] Loading cache from salt://_returners, for base)
2017-10-25 15:37:28,946 [salt.fileclient  ][INFO    ][23552] Caching directory '_returners/' for environment 'base'
2017-10-25 15:37:28,976 [salt.utils.extmods][INFO    ][23552] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-25 15:37:28,979 [salt.utils.extmods][INFO    ][23552] Syncing output for environment 'base'
2017-10-25 15:37:28,979 [salt.utils.extmods][INFO    ][23552] Loading cache from salt://_output, for base)
2017-10-25 15:37:28,979 [salt.fileclient  ][INFO    ][23552] Caching directory '_output/' for environment 'base'
2017-10-25 15:37:29,008 [salt.utils.extmods][INFO    ][23552] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-25 15:37:29,010 [salt.utils.extmods][INFO    ][23552] Syncing utils for environment 'base'
2017-10-25 15:37:29,010 [salt.utils.extmods][INFO    ][23552] Loading cache from salt://_utils, for base)
2017-10-25 15:37:29,010 [salt.fileclient  ][INFO    ][23552] Caching directory '_utils/' for environment 'base'
2017-10-25 15:37:29,034 [salt.utils.extmods][INFO    ][23552] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-25 15:37:29,037 [salt.utils.extmods][INFO    ][23552] Syncing log_handlers for environment 'base'
2017-10-25 15:37:29,037 [salt.utils.extmods][INFO    ][23552] Loading cache from salt://_log_handlers, for base)
2017-10-25 15:37:29,037 [salt.fileclient  ][INFO    ][23552] Caching directory '_log_handlers/' for environment 'base'
2017-10-25 15:37:29,076 [salt.utils.extmods][INFO    ][23552] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-25 15:37:29,079 [salt.utils.extmods][INFO    ][23552] Syncing proxy for environment 'base'
2017-10-25 15:37:29,079 [salt.utils.extmods][INFO    ][23552] Loading cache from salt://_proxy, for base)
2017-10-25 15:37:29,079 [salt.fileclient  ][INFO    ][23552] Caching directory '_proxy/' for environment 'base'
2017-10-25 15:37:29,100 [salt.utils.extmods][INFO    ][23552] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-25 15:37:29,102 [salt.utils.extmods][INFO    ][23552] Syncing engines for environment 'base'
2017-10-25 15:37:29,102 [salt.utils.extmods][INFO    ][23552] Loading cache from salt://_engines, for base)
2017-10-25 15:37:29,103 [salt.fileclient  ][INFO    ][23552] Caching directory '_engines/' for environment 'base'
2017-10-25 15:37:29,132 [salt.minion      ][INFO    ][23552] Returning information for job: 20171025153722786104
2017-10-25 15:37:37,103 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command state.sls with jid 20171025153737100431
2017-10-25 15:37:37,117 [salt.minion      ][INFO    ][23678] Starting a new job with PID 23678
2017-10-25 15:37:37,558 [salt.state       ][INFO    ][23678] Loading fresh modules for state activity
2017-10-25 15:37:37,649 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-25 15:37:37,667 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-25 15:37:37,747 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-25 15:37:37,812 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-25 15:37:37,826 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-25 15:37:37,871 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-25 15:37:37,963 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-25 15:37:37,982 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-25 15:37:38,024 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-25 15:37:38,104 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-25 15:37:38,118 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 15:37:38,134 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-25 15:37:38,142 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-25 15:37:38,164 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-25 15:37:38,179 [py.warnings      ][WARNING ][23678] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-25 15:37:38,180 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'salt-minion --version' in directory '/root'
2017-10-25 15:37:38,420 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-25 15:37:38,467 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-25 15:37:38,480 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-25 15:37:38,492 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-25 15:37:38,550 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-25 15:37:38,607 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-25 15:37:38,682 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-25 15:37:38,703 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-25 15:37:38,755 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-25 15:37:38,772 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-25 15:37:38,829 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-25 15:37:38,847 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-25 15:37:38,859 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 15:37:38,876 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-25 15:37:38,883 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-25 15:37:38,904 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-25 15:37:38,919 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'salt-minion --version' in directory '/root'
2017-10-25 15:37:39,159 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-25 15:37:39,181 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-25 15:37:39,194 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-25 15:37:39,206 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-25 15:37:39,252 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-25 15:37:39,287 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-25 15:37:39,351 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-25 15:37:39,477 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-25 15:37:39,852 [salt.state       ][INFO    ][23678] Running state [salt-minion] at time 15:37:39.851591
2017-10-25 15:37:39,852 [salt.state       ][INFO    ][23678] Executing state pkg.installed for salt-minion
2017-10-25 15:37:39,852 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 15:37:40,123 [salt.state       ][INFO    ][23678] Package salt-minion is already installed
2017-10-25 15:37:40,124 [salt.state       ][INFO    ][23678] Completed state [salt-minion] at time 15:37:40.123728 duration_in_ms=272.138
2017-10-25 15:37:40,124 [salt.state       ][INFO    ][23678] Running state [salt_minion_dependency_packages] at time 15:37:40.124011
2017-10-25 15:37:40,124 [salt.state       ][INFO    ][23678] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-25 15:37:40,127 [salt.state       ][INFO    ][23678] All specified packages are already installed
2017-10-25 15:37:40,127 [salt.state       ][INFO    ][23678] Completed state [salt_minion_dependency_packages] at time 15:37:40.127025 duration_in_ms=3.014
2017-10-25 15:37:40,129 [salt.state       ][INFO    ][23678] Running state [/etc/salt/minion.d/minion.conf] at time 15:37:40.128517
2017-10-25 15:37:40,129 [salt.state       ][INFO    ][23678] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-25 15:37:40,153 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-25 15:37:40,199 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-25 15:37:40,241 [salt.fileclient  ][INFO    ][23678] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-25 15:37:40,403 [salt.state       ][INFO    ][23678] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-25 15:37:40,403 [salt.state       ][INFO    ][23678] Completed state [/etc/salt/minion.d/minion.conf] at time 15:37:40.403399 duration_in_ms=274.881
2017-10-25 15:37:40,404 [salt.state       ][INFO    ][23678] Running state [/etc/salt/minion.d/_virt.conf] at time 15:37:40.403727
2017-10-25 15:37:40,404 [salt.state       ][INFO    ][23678] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-25 15:37:40,486 [salt.state       ][INFO    ][23678] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-25 15:37:40,486 [salt.state       ][INFO    ][23678] Completed state [/etc/salt/minion.d/_virt.conf] at time 15:37:40.486388 duration_in_ms=82.661
2017-10-25 15:37:40,488 [salt.state       ][INFO    ][23678] Running state [salt-minion] at time 15:37:40.487994
2017-10-25 15:37:40,488 [salt.state       ][INFO    ][23678] Executing state service.running for salt-minion
2017-10-25 15:37:40,489 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-25 15:37:40,508 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-25 15:37:40,517 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-25 15:37:40,526 [salt.state       ][INFO    ][23678] The service salt-minion is already running
2017-10-25 15:37:40,526 [salt.state       ][INFO    ][23678] Completed state [salt-minion] at time 15:37:40.526154 duration_in_ms=38.16
2017-10-25 15:37:40,527 [salt.state       ][INFO    ][23678] Running state [/etc/salt/grains.d] at time 15:37:40.527463
2017-10-25 15:37:40,528 [salt.state       ][INFO    ][23678] Executing state file.directory for /etc/salt/grains.d
2017-10-25 15:37:40,528 [salt.state       ][INFO    ][23678] Directory /etc/salt/grains.d is in the correct state
2017-10-25 15:37:40,528 [salt.state       ][INFO    ][23678] Completed state [/etc/salt/grains.d] at time 15:37:40.528405 duration_in_ms=0.943
2017-10-25 15:37:40,529 [salt.state       ][INFO    ][23678] Running state [/etc/salt/grains] at time 15:37:40.528836
2017-10-25 15:37:40,529 [salt.state       ][INFO    ][23678] Executing state file.managed for /etc/salt/grains
2017-10-25 15:37:40,529 [salt.state       ][INFO    ][23678] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-25 15:37:40,530 [salt.state       ][INFO    ][23678] Completed state [/etc/salt/grains] at time 15:37:40.529521 duration_in_ms=0.685
2017-10-25 15:37:40,530 [salt.state       ][INFO    ][23678] Running state [/etc/salt/grains.d/placeholder] at time 15:37:40.529799
2017-10-25 15:37:40,530 [salt.state       ][INFO    ][23678] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-25 15:37:40,530 [salt.state       ][INFO    ][23678] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-25 15:37:40,531 [salt.state       ][INFO    ][23678] Completed state [/etc/salt/grains.d/placeholder] at time 15:37:40.530494 duration_in_ms=0.695
2017-10-25 15:37:40,531 [salt.state       ][INFO    ][23678] Running state [/etc/salt/grains.d/sphinx] at time 15:37:40.530891
2017-10-25 15:37:40,531 [salt.state       ][INFO    ][23678] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-25 15:37:40,642 [salt.state       ][INFO    ][23678] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.142
               - 127.0.0.1
               - 192.168.11.252
-              - 192.168.122.1
         system:
           name: System
           param:

2017-10-25 15:37:40,643 [salt.state       ][INFO    ][23678] Completed state [/etc/salt/grains.d/sphinx] at time 15:37:40.642541 duration_in_ms=111.649
2017-10-25 15:37:40,643 [salt.state       ][INFO    ][23678] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 15:37:40.643144
2017-10-25 15:37:40,643 [salt.state       ][INFO    ][23678] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-25 15:37:40,644 [salt.state       ][INFO    ][23678] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-25 15:37:40,644 [salt.state       ][INFO    ][23678] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 15:37:40.643658 duration_in_ms=0.514
2017-10-25 15:37:40,644 [salt.state       ][INFO    ][23678] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 15:37:40.643803
2017-10-25 15:37:40,644 [salt.state       ][INFO    ][23678] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-25 15:37:40,645 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-10-25 15:37:40,729 [salt.state       ][INFO    ][23678] {'pid': 23726, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-25 15:37:40,730 [salt.state       ][INFO    ][23678] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 15:37:40.729559 duration_in_ms=85.755
2017-10-25 15:37:40,730 [salt.state       ][INFO    ][23678] Running state [/etc/salt/grains.d/dns_records] at time 15:37:40.730028
2017-10-25 15:37:40,730 [salt.state       ][INFO    ][23678] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-25 15:37:40,858 [salt.state       ][INFO    ][23678] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-25 15:37:40,859 [salt.state       ][INFO    ][23678] Completed state [/etc/salt/grains.d/dns_records] at time 15:37:40.858620 duration_in_ms=128.591
2017-10-25 15:37:40,859 [salt.state       ][INFO    ][23678] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 15:37:40.859286
2017-10-25 15:37:40,860 [salt.state       ][INFO    ][23678] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-25 15:37:40,860 [salt.state       ][INFO    ][23678] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-25 15:37:40,860 [salt.state       ][INFO    ][23678] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 15:37:40.859828 duration_in_ms=0.541
2017-10-25 15:37:40,860 [salt.state       ][INFO    ][23678] Running state [/etc/salt/grains.d/salt] at time 15:37:40.860090
2017-10-25 15:37:40,860 [salt.state       ][INFO    ][23678] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-25 15:37:41,098 [salt.state       ][INFO    ][23678] File /etc/salt/grains.d/salt is in the correct state
2017-10-25 15:37:41,098 [salt.state       ][INFO    ][23678] Completed state [/etc/salt/grains.d/salt] at time 15:37:41.098209 duration_in_ms=238.119
2017-10-25 15:37:41,099 [salt.state       ][INFO    ][23678] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 15:37:41.099051
2017-10-25 15:37:41,099 [salt.state       ][INFO    ][23678] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-25 15:37:41,100 [salt.state       ][INFO    ][23678] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-25 15:37:41,100 [salt.state       ][INFO    ][23678] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 15:37:41.099816 duration_in_ms=0.766
2017-10-25 15:37:41,101 [salt.state       ][INFO    ][23678] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 15:37:41.100988
2017-10-25 15:37:41,101 [salt.state       ][INFO    ][23678] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-25 15:37:41,101 [salt.state       ][INFO    ][23678] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-25 15:37:41,102 [salt.state       ][INFO    ][23678] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 15:37:41.101508 duration_in_ms=0.519
2017-10-25 15:37:41,102 [salt.state       ][INFO    ][23678] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 15:37:41.101640
2017-10-25 15:37:41,102 [salt.state       ][INFO    ][23678] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-25 15:37:41,103 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-10-25 15:37:41,113 [salt.state       ][INFO    ][23678] {'pid': 23729, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-25 15:37:41,114 [salt.state       ][INFO    ][23678] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 15:37:41.113541 duration_in_ms=11.9
2017-10-25 15:37:41,114 [salt.state       ][INFO    ][23678] Running state [mine.update] at time 15:37:41.114262
2017-10-25 15:37:41,115 [salt.state       ][INFO    ][23678] Executing state module.wait for mine.update
2017-10-25 15:37:41,115 [salt.state       ][INFO    ][23678] No changes made for mine.update
2017-10-25 15:37:41,115 [salt.state       ][INFO    ][23678] Completed state [mine.update] at time 15:37:41.114933 duration_in_ms=0.671
2017-10-25 15:37:41,115 [salt.state       ][INFO    ][23678] Running state [mine.update] at time 15:37:41.115107
2017-10-25 15:37:41,115 [salt.state       ][INFO    ][23678] Executing state module.mod_watch for mine.update
2017-10-25 15:37:41,639 [salt.state       ][INFO    ][23678] {'ret': True}
2017-10-25 15:37:41,639 [salt.state       ][INFO    ][23678] Completed state [mine.update] at time 15:37:41.639400 duration_in_ms=524.292
2017-10-25 15:37:41,640 [salt.state       ][INFO    ][23678] Running state [ca-certificates] at time 15:37:41.639695
2017-10-25 15:37:41,640 [salt.state       ][INFO    ][23678] Executing state pkg.installed for ca-certificates
2017-10-25 15:37:41,643 [salt.state       ][INFO    ][23678] Package ca-certificates is already installed
2017-10-25 15:37:41,644 [salt.state       ][INFO    ][23678] Completed state [ca-certificates] at time 15:37:41.643473 duration_in_ms=3.778
2017-10-25 15:37:41,644 [salt.state       ][INFO    ][23678] Running state [update-ca-certificates] at time 15:37:41.644054
2017-10-25 15:37:41,644 [salt.state       ][INFO    ][23678] Executing state cmd.wait for update-ca-certificates
2017-10-25 15:37:41,645 [salt.state       ][INFO    ][23678] No changes made for update-ca-certificates
2017-10-25 15:37:41,645 [salt.state       ][INFO    ][23678] Completed state [update-ca-certificates] at time 15:37:41.644682 duration_in_ms=0.628
2017-10-25 15:37:41,645 [salt.state       ][INFO    ][23678] Running state [libvirt-dev] at time 15:37:41.644875
2017-10-25 15:37:41,645 [salt.state       ][INFO    ][23678] Executing state pkg.installed for libvirt-dev
2017-10-25 15:37:41,648 [salt.state       ][INFO    ][23678] Package libvirt-dev is already installed
2017-10-25 15:37:41,648 [salt.state       ][INFO    ][23678] Completed state [libvirt-dev] at time 15:37:41.648014 duration_in_ms=3.14
2017-10-25 15:37:41,648 [salt.state       ][INFO    ][23678] Running state [pkg-config] at time 15:37:41.648206
2017-10-25 15:37:41,648 [salt.state       ][INFO    ][23678] Executing state pkg.installed for pkg-config
2017-10-25 15:37:41,651 [salt.state       ][INFO    ][23678] Package pkg-config is already installed
2017-10-25 15:37:41,651 [salt.state       ][INFO    ][23678] Completed state [pkg-config] at time 15:37:41.651362 duration_in_ms=3.155
2017-10-25 15:37:41,652 [salt.state       ][INFO    ][23678] Running state [virtng.init] at time 15:37:41.651553
2017-10-25 15:37:41,652 [salt.state       ][INFO    ][23678] Executing state module.run for virtng.init
2017-10-25 15:37:41,710 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command ['git', '--version'] in directory '/root'
2017-10-25 15:37:41,877 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-25 15:37:41,895 [salt.state       ][INFO    ][23678] unless execution succeeded
2017-10-25 15:37:41,895 [salt.state       ][INFO    ][23678] Completed state [virtng.init] at time 15:37:41.895003 duration_in_ms=243.447
2017-10-25 15:37:41,895 [salt.state       ][INFO    ][23678] Running state [virt.set_autostart] at time 15:37:41.895229
2017-10-25 15:37:41,895 [salt.state       ][INFO    ][23678] Executing state module.run for virt.set_autostart
2017-10-25 15:37:41,897 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-25 15:37:41,913 [salt.state       ][INFO    ][23678] unless execution succeeded
2017-10-25 15:37:41,931 [salt.state       ][INFO    ][23678] Completed state [virt.set_autostart] at time 15:37:41.930801 duration_in_ms=35.57
2017-10-25 15:37:41,931 [salt.state       ][INFO    ][23678] Running state [virtng.init] at time 15:37:41.931132
2017-10-25 15:37:41,931 [salt.state       ][INFO    ][23678] Executing state module.run for virtng.init
2017-10-25 15:37:41,933 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-25 15:37:41,951 [salt.state       ][INFO    ][23678] unless execution succeeded
2017-10-25 15:37:41,951 [salt.state       ][INFO    ][23678] Completed state [virtng.init] at time 15:37:41.950793 duration_in_ms=19.66
2017-10-25 15:37:41,951 [salt.state       ][INFO    ][23678] Running state [virt.set_autostart] at time 15:37:41.951009
2017-10-25 15:37:41,951 [salt.state       ][INFO    ][23678] Executing state module.run for virt.set_autostart
2017-10-25 15:37:41,953 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-25 15:37:41,969 [salt.state       ][INFO    ][23678] unless execution succeeded
2017-10-25 15:37:41,969 [salt.state       ][INFO    ][23678] Completed state [virt.set_autostart] at time 15:37:41.968893 duration_in_ms=17.884
2017-10-25 15:37:41,969 [salt.state       ][INFO    ][23678] Running state [virtng.init] at time 15:37:41.969109
2017-10-25 15:37:41,969 [salt.state       ][INFO    ][23678] Executing state module.run for virtng.init
2017-10-25 15:37:41,971 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-25 15:37:41,988 [salt.state       ][INFO    ][23678] unless execution succeeded
2017-10-25 15:37:41,988 [salt.state       ][INFO    ][23678] Completed state [virtng.init] at time 15:37:41.987817 duration_in_ms=18.707
2017-10-25 15:37:41,988 [salt.state       ][INFO    ][23678] Running state [virt.set_autostart] at time 15:37:41.988023
2017-10-25 15:37:41,988 [salt.state       ][INFO    ][23678] Executing state module.run for virt.set_autostart
2017-10-25 15:37:41,990 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-25 15:37:42,006 [salt.state       ][INFO    ][23678] unless execution succeeded
2017-10-25 15:37:42,006 [salt.state       ][INFO    ][23678] Completed state [virt.set_autostart] at time 15:37:42.006283 duration_in_ms=18.259
2017-10-25 15:37:42,007 [salt.state       ][INFO    ][23678] Running state [virtng.init] at time 15:37:42.006525
2017-10-25 15:37:42,007 [salt.state       ][INFO    ][23678] Executing state module.run for virtng.init
2017-10-25 15:37:42,009 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-25 15:37:42,022 [salt.state       ][INFO    ][23678] unless execution succeeded
2017-10-25 15:37:42,022 [salt.state       ][INFO    ][23678] Completed state [virtng.init] at time 15:37:42.022120 duration_in_ms=15.594
2017-10-25 15:37:42,022 [salt.state       ][INFO    ][23678] Running state [virt.set_autostart] at time 15:37:42.022357
2017-10-25 15:37:42,023 [salt.state       ][INFO    ][23678] Executing state module.run for virt.set_autostart
2017-10-25 15:37:42,024 [salt.loaded.int.module.cmdmod][INFO    ][23678] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-25 15:37:42,037 [salt.state       ][INFO    ][23678] unless execution succeeded
2017-10-25 15:37:42,037 [salt.state       ][INFO    ][23678] Completed state [virt.set_autostart] at time 15:37:42.037089 duration_in_ms=14.731
2017-10-25 15:37:42,040 [salt.minion      ][INFO    ][23678] Returning information for job: 20171025153737100431
2017-10-25 15:38:47,666 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171025153847667470
2017-10-25 15:38:47,682 [salt.minion      ][INFO    ][23780] Starting a new job with PID 23780
2017-10-25 15:38:50,946 [salt.state       ][INFO    ][23780] Loading fresh modules for state activity
2017-10-25 15:38:51,291 [salt.state       ][ERROR   ][23780] No contents found in top file
2017-10-25 15:38:51,292 [salt.utils.extmods][INFO    ][23780] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-25 15:38:51,295 [salt.utils.extmods][INFO    ][23780] Syncing beacons for environment 'base'
2017-10-25 15:38:51,295 [salt.utils.extmods][INFO    ][23780] Loading cache from salt://_beacons, for base)
2017-10-25 15:38:51,295 [salt.fileclient  ][INFO    ][23780] Caching directory '_beacons/' for environment 'base'
2017-10-25 15:38:51,319 [salt.utils.extmods][INFO    ][23780] Syncing modules for environment 'base'
2017-10-25 15:38:51,320 [salt.utils.extmods][INFO    ][23780] Loading cache from salt://_modules, for base)
2017-10-25 15:38:51,320 [salt.fileclient  ][INFO    ][23780] Caching directory '_modules/' for environment 'base'
2017-10-25 15:38:51,406 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-25 15:38:51,461 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-25 15:38:51,506 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-25 15:38:51,522 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-25 15:38:51,541 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-25 15:38:51,584 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-25 15:38:51,621 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-25 15:38:51,636 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-25 15:38:51,659 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-25 15:38:51,696 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-25 15:38:51,705 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-25 15:38:51,738 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-25 15:38:51,750 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-25 15:38:51,803 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-25 15:38:51,814 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-25 15:38:51,868 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-25 15:38:51,878 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-25 15:38:51,907 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-25 15:38:51,936 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-25 15:38:51,949 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-25 15:38:51,957 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-25 15:38:52,008 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-25 15:38:52,033 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-25 15:38:52,040 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-25 15:38:52,101 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-25 15:38:52,121 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-25 15:38:52,139 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-25 15:38:52,194 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-25 15:38:52,202 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-25 15:38:52,215 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-25 15:38:52,235 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-25 15:38:52,253 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-25 15:38:52,255 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-25 15:38:52,256 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-25 15:38:52,256 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-25 15:38:52,256 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-25 15:38:52,256 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-25 15:38:52,257 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-25 15:38:52,257 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-25 15:38:52,257 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-25 15:38:52,258 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-25 15:38:52,258 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-25 15:38:52,258 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-25 15:38:52,258 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-25 15:38:52,259 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-25 15:38:52,259 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-25 15:38:52,259 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-25 15:38:52,259 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-25 15:38:52,259 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-25 15:38:52,260 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-25 15:38:52,260 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-25 15:38:52,260 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-25 15:38:52,261 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-25 15:38:52,261 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-25 15:38:52,261 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-25 15:38:52,262 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-25 15:38:52,262 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-25 15:38:52,262 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-25 15:38:52,262 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-25 15:38:52,263 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-25 15:38:52,263 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-25 15:38:52,263 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-25 15:38:52,263 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-25 15:38:52,264 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-10-25 15:38:52,264 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-25 15:38:52,264 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-25 15:38:52,268 [salt.utils.extmods][INFO    ][23780] Syncing states for environment 'base'
2017-10-25 15:38:52,268 [salt.utils.extmods][INFO    ][23780] Loading cache from salt://_states, for base)
2017-10-25 15:38:52,269 [salt.fileclient  ][INFO    ][23780] Caching directory '_states/' for environment 'base'
2017-10-25 15:38:52,327 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-25 15:38:52,355 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-25 15:38:52,369 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-25 15:38:52,378 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-25 15:38:52,420 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-25 15:38:52,431 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-25 15:38:52,478 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-25 15:38:52,504 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-25 15:38:52,556 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-25 15:38:52,567 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-25 15:38:52,584 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-25 15:38:52,619 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-25 15:38:52,636 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-25 15:38:52,650 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-25 15:38:52,699 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-25 15:38:52,754 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-25 15:38:52,764 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-25 15:38:52,814 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-25 15:38:52,822 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-25 15:38:52,857 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-25 15:38:52,867 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-25 15:38:52,875 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-25 15:38:52,887 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-25 15:38:52,915 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-25 15:38:52,922 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-25 15:38:52,943 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-25 15:38:52,952 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-25 15:38:53,381 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-25 15:38:53,393 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-25 15:38:53,396 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-25 15:38:53,396 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-25 15:38:53,396 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-25 15:38:53,396 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-25 15:38:53,397 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-25 15:38:53,397 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-25 15:38:53,397 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-25 15:38:53,398 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-25 15:38:53,398 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-25 15:38:53,398 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-25 15:38:53,398 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-25 15:38:53,399 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-25 15:38:53,399 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-25 15:38:53,399 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-25 15:38:53,399 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-25 15:38:53,400 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-25 15:38:53,400 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-25 15:38:53,400 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-25 15:38:53,401 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-25 15:38:53,401 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-25 15:38:53,401 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-25 15:38:53,401 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-25 15:38:53,402 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-25 15:38:53,402 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-25 15:38:53,402 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-25 15:38:53,402 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-25 15:38:53,403 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-25 15:38:53,403 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-25 15:38:53,403 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-25 15:38:53,403 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-25 15:38:53,406 [salt.utils.extmods][INFO    ][23780] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-25 15:38:53,409 [salt.utils.extmods][INFO    ][23780] Syncing sdb for environment 'base'
2017-10-25 15:38:53,409 [salt.utils.extmods][INFO    ][23780] Loading cache from salt://_sdb, for base)
2017-10-25 15:38:53,409 [salt.fileclient  ][INFO    ][23780] Caching directory '_sdb/' for environment 'base'
2017-10-25 15:38:53,440 [salt.utils.extmods][INFO    ][23780] Syncing grains for environment 'base'
2017-10-25 15:38:53,440 [salt.utils.extmods][INFO    ][23780] Loading cache from salt://_grains, for base)
2017-10-25 15:38:53,440 [salt.fileclient  ][INFO    ][23780] Caching directory '_grains/' for environment 'base'
2017-10-25 15:38:53,470 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-25 15:38:53,477 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-25 15:38:53,608 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-25 15:38:53,620 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-25 15:38:53,892 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-25 15:38:53,899 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-25 15:38:53,914 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-25 15:38:53,922 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-25 15:38:53,927 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-25 15:38:53,939 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-25 15:38:53,945 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-25 15:38:53,951 [salt.fileclient  ][INFO    ][23780] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-25 15:38:53,954 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-25 15:38:53,954 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-25 15:38:53,954 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-25 15:38:53,954 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-25 15:38:53,954 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-25 15:38:53,955 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-25 15:38:53,955 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-25 15:38:53,955 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-25 15:38:53,955 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-25 15:38:53,955 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-25 15:38:53,956 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-25 15:38:53,956 [salt.utils.extmods][INFO    ][23780] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-25 15:38:53,957 [salt.utils.extmods][INFO    ][23780] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-25 15:38:53,959 [salt.utils.extmods][INFO    ][23780] Syncing renderers for environment 'base'
2017-10-25 15:38:53,960 [salt.utils.extmods][INFO    ][23780] Loading cache from salt://_renderers, for base)
2017-10-25 15:38:53,960 [salt.fileclient  ][INFO    ][23780] Caching directory '_renderers/' for environment 'base'
2017-10-25 15:38:54,001 [salt.utils.extmods][INFO    ][23780] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-25 15:38:54,004 [salt.utils.extmods][INFO    ][23780] Syncing returners for environment 'base'
2017-10-25 15:38:54,004 [salt.utils.extmods][INFO    ][23780] Loading cache from salt://_returners, for base)
2017-10-25 15:38:54,004 [salt.fileclient  ][INFO    ][23780] Caching directory '_returners/' for environment 'base'
2017-10-25 15:38:54,021 [salt.utils.extmods][INFO    ][23780] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-25 15:38:54,023 [salt.utils.extmods][INFO    ][23780] Syncing output for environment 'base'
2017-10-25 15:38:54,023 [salt.utils.extmods][INFO    ][23780] Loading cache from salt://_output, for base)
2017-10-25 15:38:54,023 [salt.fileclient  ][INFO    ][23780] Caching directory '_output/' for environment 'base'
2017-10-25 15:38:54,043 [salt.utils.extmods][INFO    ][23780] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-25 15:38:54,046 [salt.utils.extmods][INFO    ][23780] Syncing utils for environment 'base'
2017-10-25 15:38:54,046 [salt.utils.extmods][INFO    ][23780] Loading cache from salt://_utils, for base)
2017-10-25 15:38:54,046 [salt.fileclient  ][INFO    ][23780] Caching directory '_utils/' for environment 'base'
2017-10-25 15:38:54,075 [salt.utils.extmods][INFO    ][23780] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-25 15:38:54,077 [salt.utils.extmods][INFO    ][23780] Syncing log_handlers for environment 'base'
2017-10-25 15:38:54,077 [salt.utils.extmods][INFO    ][23780] Loading cache from salt://_log_handlers, for base)
2017-10-25 15:38:54,077 [salt.fileclient  ][INFO    ][23780] Caching directory '_log_handlers/' for environment 'base'
2017-10-25 15:38:54,101 [salt.utils.extmods][INFO    ][23780] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-25 15:38:54,104 [salt.utils.extmods][INFO    ][23780] Syncing proxy for environment 'base'
2017-10-25 15:38:54,104 [salt.utils.extmods][INFO    ][23780] Loading cache from salt://_proxy, for base)
2017-10-25 15:38:54,104 [salt.fileclient  ][INFO    ][23780] Caching directory '_proxy/' for environment 'base'
2017-10-25 15:38:54,131 [salt.utils.extmods][INFO    ][23780] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-25 15:38:54,134 [salt.utils.extmods][INFO    ][23780] Syncing engines for environment 'base'
2017-10-25 15:38:54,134 [salt.utils.extmods][INFO    ][23780] Loading cache from salt://_engines, for base)
2017-10-25 15:38:54,134 [salt.fileclient  ][INFO    ][23780] Caching directory '_engines/' for environment 'base'
2017-10-25 15:38:54,158 [salt.minion      ][INFO    ][23780] Returning information for job: 20171025153847667470
2017-10-25 15:46:48,815 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command test.ping with jid 20171025154648804443
2017-10-25 15:46:48,833 [salt.minion      ][INFO    ][23996] Starting a new job with PID 23996
2017-10-25 15:46:48,857 [salt.minion      ][INFO    ][23996] Returning information for job: 20171025154648804443
2017-10-25 15:48:14,829 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command state.sls with jid 20171025154814811501
2017-10-25 15:48:14,841 [salt.minion      ][INFO    ][24027] Starting a new job with PID 24027
2017-10-25 15:48:16,374 [salt.state       ][INFO    ][24027] Loading fresh modules for state activity
2017-10-25 15:48:16,398 [salt.fileclient  ][INFO    ][24027] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-25 15:48:16,416 [salt.fileclient  ][INFO    ][24027] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-25 15:48:16,440 [salt.fileclient  ][INFO    ][24027] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 15:48:16,727 [salt.state       ][INFO    ][24027] Running state [lsof] at time 15:48:16.726535
2017-10-25 15:48:16,727 [salt.state       ][INFO    ][24027] Executing state pkg.installed for lsof
2017-10-25 15:48:16,727 [salt.loaded.int.module.cmdmod][INFO    ][24027] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 15:48:16,987 [salt.state       ][INFO    ][24027] Package lsof is already installed
2017-10-25 15:48:16,987 [salt.state       ][INFO    ][24027] Completed state [lsof] at time 15:48:16.986943 duration_in_ms=260.409
2017-10-25 15:48:16,987 [salt.state       ][INFO    ][24027] Running state [keepalived] at time 15:48:16.987135
2017-10-25 15:48:16,987 [salt.state       ][INFO    ][24027] Executing state pkg.installed for keepalived
2017-10-25 15:48:17,002 [salt.loaded.int.module.cmdmod][INFO    ][24027] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-25 15:48:18,916 [salt.loaded.int.module.cmdmod][INFO    ][24027] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-10-25 15:48:24,872 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command saltutil.find_job with jid 20171025154824854295
2017-10-25 15:48:24,888 [salt.minion      ][INFO    ][25332] Starting a new job with PID 25332
2017-10-25 15:48:24,898 [salt.minion      ][INFO    ][25332] Returning information for job: 20171025154824854295
2017-10-25 15:48:26,817 [salt.loaded.int.module.cmdmod][INFO    ][24027] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 15:48:26,840 [salt.state       ][INFO    ][24027] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-10-25 15:48:26,848 [salt.state       ][INFO    ][24027] Loading fresh modules for state activity
2017-10-25 15:48:26,860 [salt.state       ][INFO    ][24027] Completed state [keepalived] at time 15:48:26.859810 duration_in_ms=9872.675
2017-10-25 15:48:26,862 [salt.state       ][INFO    ][24027] Running state [/etc/keepalived/keepalived.conf] at time 15:48:26.861746
2017-10-25 15:48:26,862 [salt.state       ][INFO    ][24027] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-25 15:48:26,889 [salt.fileclient  ][INFO    ][24027] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-25 15:48:26,919 [salt.fileclient  ][INFO    ][24027] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 15:48:26,925 [salt.state       ][INFO    ][24027] File changed:
New file
2017-10-25 15:48:26,925 [salt.state       ][INFO    ][24027] Completed state [/etc/keepalived/keepalived.conf] at time 15:48:26.925245 duration_in_ms=63.498
2017-10-25 15:48:26,982 [salt.state       ][INFO    ][24027] Running state [keepalived] at time 15:48:26.981775
2017-10-25 15:48:26,982 [salt.state       ][INFO    ][24027] Executing state service.running for keepalived
2017-10-25 15:48:26,983 [salt.loaded.int.module.cmdmod][INFO    ][24027] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-25 15:48:26,993 [salt.loaded.int.module.cmdmod][INFO    ][24027] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-25 15:48:27,001 [salt.loaded.int.module.cmdmod][INFO    ][24027] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-25 15:48:27,008 [salt.loaded.int.module.cmdmod][INFO    ][24027] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-25 15:48:27,015 [salt.loaded.int.module.cmdmod][INFO    ][24027] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-10-25 15:48:27,066 [salt.loaded.int.module.cmdmod][INFO    ][24027] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-25 15:48:27,073 [salt.loaded.int.module.cmdmod][INFO    ][24027] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-25 15:48:27,080 [salt.loaded.int.module.cmdmod][INFO    ][24027] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-25 15:48:27,087 [salt.state       ][INFO    ][24027] {'keepalived': True}
2017-10-25 15:48:27,087 [salt.state       ][INFO    ][24027] Completed state [keepalived] at time 15:48:27.087007 duration_in_ms=105.231
2017-10-25 15:48:27,088 [salt.minion      ][INFO    ][24027] Returning information for job: 20171025154814811501
2017-10-25 15:50:50,661 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command pillar.get with jid 20171025155050642409
2017-10-25 15:50:50,681 [salt.minion      ][INFO    ][25643] Starting a new job with PID 25643
2017-10-25 15:50:50,686 [salt.minion      ][INFO    ][25643] Returning information for job: 20171025155050642409
2017-10-25 15:56:05,285 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command state.sls with jid 20171025155605268334
2017-10-25 15:56:05,299 [salt.minion      ][INFO    ][25721] Starting a new job with PID 25721
2017-10-25 15:56:06,989 [salt.state       ][INFO    ][25721] Loading fresh modules for state activity
2017-10-25 15:56:07,015 [salt.fileclient  ][INFO    ][25721] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-25 15:56:07,039 [salt.fileclient  ][INFO    ][25721] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 15:56:07,321 [salt.state       ][INFO    ][25721] Running state [attr] at time 15:56:07.320949
2017-10-25 15:56:07,321 [salt.state       ][INFO    ][25721] Executing state pkg.installed for attr
2017-10-25 15:56:07,322 [salt.loaded.int.module.cmdmod][INFO    ][25721] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 15:56:07,633 [salt.loaded.int.module.cmdmod][INFO    ][25721] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-25 15:56:11,345 [salt.loaded.int.module.cmdmod][INFO    ][25721] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-10-25 15:56:13,812 [salt.loaded.int.module.cmdmod][INFO    ][25721] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 15:56:13,835 [salt.state       ][INFO    ][25721] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-10-25 15:56:13,843 [salt.state       ][INFO    ][25721] Loading fresh modules for state activity
2017-10-25 15:56:13,855 [salt.state       ][INFO    ][25721] Completed state [attr] at time 15:56:13.854918 duration_in_ms=6533.969
2017-10-25 15:56:13,860 [salt.state       ][INFO    ][25721] Running state [glusterfs-server] at time 15:56:13.859519
2017-10-25 15:56:13,860 [salt.state       ][INFO    ][25721] Executing state pkg.installed for glusterfs-server
2017-10-25 15:56:14,041 [salt.loaded.int.module.cmdmod][INFO    ][25721] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-10-25 15:56:15,378 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command saltutil.find_job with jid 20171025155615360209
2017-10-25 15:56:15,393 [salt.minion      ][INFO    ][26736] Starting a new job with PID 26736
2017-10-25 15:56:15,403 [salt.minion      ][INFO    ][26736] Returning information for job: 20171025155615360209
2017-10-25 15:56:25,583 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command saltutil.find_job with jid 20171025155625563567
2017-10-25 15:56:25,598 [salt.minion      ][INFO    ][29472] Starting a new job with PID 29472
2017-10-25 15:56:25,608 [salt.minion      ][INFO    ][29472] Returning information for job: 20171025155625563567
2017-10-25 15:56:31,832 [salt.loaded.int.module.cmdmod][INFO    ][25721] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 15:56:31,856 [salt.state       ][INFO    ][25721] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-10-25 15:56:31,863 [salt.state       ][INFO    ][25721] Loading fresh modules for state activity
2017-10-25 15:56:31,875 [salt.state       ][INFO    ][25721] Completed state [glusterfs-server] at time 15:56:31.874827 duration_in_ms=18015.307
2017-10-25 15:56:31,879 [salt.state       ][INFO    ][25721] Running state [bc] at time 15:56:31.879207
2017-10-25 15:56:31,879 [salt.state       ][INFO    ][25721] Executing state pkg.installed for bc
2017-10-25 15:56:32,128 [salt.loaded.int.module.cmdmod][INFO    ][25721] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-10-25 15:56:34,946 [salt.loaded.int.module.cmdmod][INFO    ][25721] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 15:56:34,971 [salt.state       ][INFO    ][25721] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-10-25 15:56:34,979 [salt.state       ][INFO    ][25721] Loading fresh modules for state activity
2017-10-25 15:56:34,992 [salt.state       ][INFO    ][25721] Completed state [bc] at time 15:56:34.991477 duration_in_ms=3112.27
2017-10-25 15:56:35,051 [salt.state       ][INFO    ][25721] Running state [glusterfs-server] at time 15:56:35.051457
2017-10-25 15:56:35,052 [salt.state       ][INFO    ][25721] Executing state service.running for glusterfs-server
2017-10-25 15:56:35,053 [salt.loaded.int.module.cmdmod][INFO    ][25721] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-25 15:56:35,063 [salt.loaded.int.module.cmdmod][INFO    ][25721] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-25 15:56:35,071 [salt.loaded.int.module.cmdmod][INFO    ][25721] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-25 15:56:35,080 [salt.state       ][INFO    ][25721] The service glusterfs-server is already running
2017-10-25 15:56:35,080 [salt.state       ][INFO    ][25721] Completed state [glusterfs-server] at time 15:56:35.080441 duration_in_ms=28.984
2017-10-25 15:56:35,082 [salt.state       ][INFO    ][25721] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 15:56:35.081713
2017-10-25 15:56:35,082 [salt.state       ][INFO    ][25721] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-25 15:56:35,095 [salt.state       ][INFO    ][25721] File changed:
New file
2017-10-25 15:56:35,095 [salt.state       ][INFO    ][25721] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 15:56:35.095206 duration_in_ms=13.494
2017-10-25 15:56:35,095 [salt.state       ][INFO    ][25721] Running state [/srv/glusterfs/glance] at time 15:56:35.095350
2017-10-25 15:56:35,096 [salt.state       ][INFO    ][25721] Executing state file.directory for /srv/glusterfs/glance
2017-10-25 15:56:35,096 [salt.state       ][INFO    ][25721] {'/srv/glusterfs/glance': 'New Dir'}
2017-10-25 15:56:35,096 [salt.state       ][INFO    ][25721] Completed state [/srv/glusterfs/glance] at time 15:56:35.096134 duration_in_ms=0.784
2017-10-25 15:56:35,096 [salt.state       ][INFO    ][25721] Running state [/srv/glusterfs/keystone-keys] at time 15:56:35.096271
2017-10-25 15:56:35,096 [salt.state       ][INFO    ][25721] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-25 15:56:35,097 [salt.state       ][INFO    ][25721] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-10-25 15:56:35,097 [salt.state       ][INFO    ][25721] Completed state [/srv/glusterfs/keystone-keys] at time 15:56:35.096875 duration_in_ms=0.603
2017-10-25 15:56:35,097 [salt.state       ][INFO    ][25721] Running state [/srv/glusterfs/nova_instances] at time 15:56:35.097014
2017-10-25 15:56:35,097 [salt.state       ][INFO    ][25721] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-25 15:56:35,098 [salt.state       ][INFO    ][25721] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-10-25 15:56:35,098 [salt.state       ][INFO    ][25721] Completed state [/srv/glusterfs/nova_instances] at time 15:56:35.097637 duration_in_ms=0.624
2017-10-25 15:56:35,098 [salt.state       ][INFO    ][25721] Running state [/srv/glusterfs/keystone-credential-keys] at time 15:56:35.097777
2017-10-25 15:56:35,098 [salt.state       ][INFO    ][25721] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-25 15:56:35,098 [salt.state       ][INFO    ][25721] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-10-25 15:56:35,098 [salt.state       ][INFO    ][25721] Completed state [/srv/glusterfs/keystone-credential-keys] at time 15:56:35.098420 duration_in_ms=0.643
2017-10-25 15:56:35,099 [salt.minion      ][INFO    ][25721] Returning information for job: 20171025155605268334
2017-10-25 15:56:36,047 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command test.ping with jid 20171025155636030852
2017-10-25 15:56:36,062 [salt.minion      ][INFO    ][30489] Starting a new job with PID 30489
2017-10-25 15:56:36,087 [salt.minion      ][INFO    ][30489] Returning information for job: 20171025155636030852
2017-10-25 15:57:16,958 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command state.sls with jid 20171025155716940366
2017-10-25 15:57:16,973 [salt.minion      ][INFO    ][30706] Starting a new job with PID 30706
2017-10-25 15:57:18,414 [salt.state       ][INFO    ][30706] Loading fresh modules for state activity
2017-10-25 15:57:18,436 [salt.fileclient  ][INFO    ][30706] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-25 15:57:18,469 [salt.fileclient  ][INFO    ][30706] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 15:57:18,533 [salt.fileclient  ][INFO    ][30706] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-25 15:57:18,552 [salt.fileclient  ][INFO    ][30706] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 15:57:18,805 [salt.state       ][INFO    ][30706] Running state [attr] at time 15:57:18.804679
2017-10-25 15:57:18,805 [salt.state       ][INFO    ][30706] Executing state pkg.installed for attr
2017-10-25 15:57:18,805 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 15:57:19,062 [salt.state       ][INFO    ][30706] Package attr is already installed
2017-10-25 15:57:19,063 [salt.state       ][INFO    ][30706] Completed state [attr] at time 15:57:19.062669 duration_in_ms=257.99
2017-10-25 15:57:19,063 [salt.state       ][INFO    ][30706] Running state [glusterfs-server] at time 15:57:19.062856
2017-10-25 15:57:19,063 [salt.state       ][INFO    ][30706] Executing state pkg.installed for glusterfs-server
2017-10-25 15:57:19,066 [salt.state       ][INFO    ][30706] Package glusterfs-server is already installed
2017-10-25 15:57:19,066 [salt.state       ][INFO    ][30706] Completed state [glusterfs-server] at time 15:57:19.065706 duration_in_ms=2.85
2017-10-25 15:57:19,066 [salt.state       ][INFO    ][30706] Running state [bc] at time 15:57:19.065842
2017-10-25 15:57:19,066 [salt.state       ][INFO    ][30706] Executing state pkg.installed for bc
2017-10-25 15:57:19,069 [salt.state       ][INFO    ][30706] Package bc is already installed
2017-10-25 15:57:19,069 [salt.state       ][INFO    ][30706] Completed state [bc] at time 15:57:19.068643 duration_in_ms=2.8
2017-10-25 15:57:19,069 [salt.state       ][INFO    ][30706] Running state [glusterfs-server] at time 15:57:19.069402
2017-10-25 15:57:19,070 [salt.state       ][INFO    ][30706] Executing state service.running for glusterfs-server
2017-10-25 15:57:19,070 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-25 15:57:19,080 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-10-25 15:57:19,122 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-25 15:57:19,137 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-25 15:57:19,145 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-25 15:57:19,153 [salt.state       ][INFO    ][30706] The service glusterfs-server is already running
2017-10-25 15:57:19,153 [salt.state       ][INFO    ][30706] Completed state [glusterfs-server] at time 15:57:19.153347 duration_in_ms=83.944
2017-10-25 15:57:19,155 [salt.state       ][INFO    ][30706] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 15:57:19.154930
2017-10-25 15:57:19,155 [salt.state       ][INFO    ][30706] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-25 15:57:19,164 [salt.state       ][INFO    ][30706] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-25 15:57:19,165 [salt.state       ][INFO    ][30706] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 15:57:19.164617 duration_in_ms=9.687
2017-10-25 15:57:19,165 [salt.state       ][INFO    ][30706] Running state [/srv/glusterfs/glance] at time 15:57:19.164788
2017-10-25 15:57:19,165 [salt.state       ][INFO    ][30706] Executing state file.directory for /srv/glusterfs/glance
2017-10-25 15:57:19,165 [salt.state       ][INFO    ][30706] Directory /srv/glusterfs/glance is in the correct state
2017-10-25 15:57:19,166 [salt.state       ][INFO    ][30706] Completed state [/srv/glusterfs/glance] at time 15:57:19.165483 duration_in_ms=0.695
2017-10-25 15:57:19,166 [salt.state       ][INFO    ][30706] Running state [/srv/glusterfs/keystone-keys] at time 15:57:19.165643
2017-10-25 15:57:19,166 [salt.state       ][INFO    ][30706] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-25 15:57:19,166 [salt.state       ][INFO    ][30706] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-25 15:57:19,166 [salt.state       ][INFO    ][30706] Completed state [/srv/glusterfs/keystone-keys] at time 15:57:19.166302 duration_in_ms=0.658
2017-10-25 15:57:19,166 [salt.state       ][INFO    ][30706] Running state [/srv/glusterfs/nova_instances] at time 15:57:19.166462
2017-10-25 15:57:19,167 [salt.state       ][INFO    ][30706] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-25 15:57:19,167 [salt.state       ][INFO    ][30706] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-25 15:57:19,167 [salt.state       ][INFO    ][30706] Completed state [/srv/glusterfs/nova_instances] at time 15:57:19.167092 duration_in_ms=0.629
2017-10-25 15:57:19,167 [salt.state       ][INFO    ][30706] Running state [/srv/glusterfs/keystone-credential-keys] at time 15:57:19.167255
2017-10-25 15:57:19,167 [salt.state       ][INFO    ][30706] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-25 15:57:19,168 [salt.state       ][INFO    ][30706] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-25 15:57:19,168 [salt.state       ][INFO    ][30706] Completed state [/srv/glusterfs/keystone-credential-keys] at time 15:57:19.167879 duration_in_ms=0.624
2017-10-25 15:57:19,221 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command ['git', '--version'] in directory '/root'
2017-10-25 15:57:19,302 [salt.state       ][INFO    ][30706] Running state [sleep 5] at time 15:57:19.301888
2017-10-25 15:57:19,302 [salt.state       ][INFO    ][30706] Executing state cmd.wait for sleep 5
2017-10-25 15:57:19,302 [salt.state       ][INFO    ][30706] No changes made for sleep 5
2017-10-25 15:57:19,302 [salt.state       ][INFO    ][30706] Completed state [sleep 5] at time 15:57:19.302467 duration_in_ms=0.579
2017-10-25 15:57:19,303 [salt.state       ][INFO    ][30706] Running state [10.167.4.141] at time 15:57:19.302830
2017-10-25 15:57:19,303 [salt.state       ][INFO    ][30706] Executing state glusterfs.peered for 10.167.4.141
2017-10-25 15:57:19,303 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:19,313 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:19,362 [salt.state       ][INFO    ][30706] Host 10.167.4.141 already peered
2017-10-25 15:57:19,362 [salt.state       ][INFO    ][30706] Completed state [10.167.4.141] at time 15:57:19.362100 duration_in_ms=59.268
2017-10-25 15:57:19,364 [salt.state       ][INFO    ][30706] Running state [10.167.4.142] at time 15:57:19.364289
2017-10-25 15:57:19,364 [salt.state       ][INFO    ][30706] Executing state glusterfs.peered for 10.167.4.142
2017-10-25 15:57:19,365 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:19,374 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:19,425 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:19,434 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:19,482 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:19,491 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:19,540 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:19,549 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:19,601 [salt.state       ][INFO    ][30706] Peering with localhost is not needed
2017-10-25 15:57:19,601 [salt.state       ][INFO    ][30706] Completed state [10.167.4.142] at time 15:57:19.601130 duration_in_ms=236.839
2017-10-25 15:57:19,603 [salt.state       ][INFO    ][30706] Running state [10.167.4.143] at time 15:57:19.603360
2017-10-25 15:57:19,604 [salt.state       ][INFO    ][30706] Executing state glusterfs.peered for 10.167.4.143
2017-10-25 15:57:19,604 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:19,612 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:19,660 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:19,669 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:19,723 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:19,732 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:19,798 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:19,807 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:19,856 [salt.state       ][INFO    ][30706] {'new': {'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': ['10.167.4.143'], '10.167.4.141': []}, 'old': {'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': [], '10.167.4.141': []}}
2017-10-25 15:57:19,856 [salt.state       ][INFO    ][30706] Completed state [10.167.4.143] at time 15:57:19.856326 duration_in_ms=252.966
2017-10-25 15:57:19,857 [salt.state       ][INFO    ][30706] Running state [glance] at time 15:57:19.857048
2017-10-25 15:57:19,857 [salt.state       ][INFO    ][30706] Executing state glusterfs.created for glance
2017-10-25 15:57:19,858 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:19,866 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:19,914 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:19,923 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:19,975 [salt.state       ][INFO    ][30706] Volume glance already exists and is started.
2017-10-25 15:57:19,975 [salt.state       ][INFO    ][30706] Completed state [glance] at time 15:57:19.975077 duration_in_ms=118.028
2017-10-25 15:57:19,978 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 15:57:19.977581
2017-10-25 15:57:19,978 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 15:57:19,978 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 15:57:20,026 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:20,027 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 15:57:20.026567 duration_in_ms=48.985
2017-10-25 15:57:20,027 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 15:57:20.027046
2017-10-25 15:57:20,027 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-25 15:57:20,028 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 15:57:20,074 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:20,075 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 15:57:20.074645 duration_in_ms=47.599
2017-10-25 15:57:20,075 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 15:57:20.075069
2017-10-25 15:57:20,075 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-25 15:57:20,076 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 15:57:20,123 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:20,123 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 15:57:20.123041 duration_in_ms=47.971
2017-10-25 15:57:20,124 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 15:57:20.123474
2017-10-25 15:57:20,124 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 15:57:20,124 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 15:57:20,171 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:20,171 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 15:57:20.171133 duration_in_ms=47.658
2017-10-25 15:57:20,172 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 15:57:20.171587
2017-10-25 15:57:20,172 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-25 15:57:20,172 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 15:57:20,223 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:20,223 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 15:57:20.223088 duration_in_ms=51.5
2017-10-25 15:57:20,224 [salt.state       ][INFO    ][30706] Running state [glance] at time 15:57:20.223987
2017-10-25 15:57:20,224 [salt.state       ][INFO    ][30706] Executing state glusterfs.started for glance
2017-10-25 15:57:20,225 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:20,233 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:20,281 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:20,289 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:20,341 [salt.state       ][INFO    ][30706] Volume glance is already started
2017-10-25 15:57:20,341 [salt.state       ][INFO    ][30706] Completed state [glance] at time 15:57:20.341260 duration_in_ms=117.272
2017-10-25 15:57:20,342 [salt.state       ][INFO    ][30706] Running state [keystone-keys] at time 15:57:20.342110
2017-10-25 15:57:20,342 [salt.state       ][INFO    ][30706] Executing state glusterfs.created for keystone-keys
2017-10-25 15:57:20,343 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:20,351 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:20,398 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:20,406 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:20,458 [salt.state       ][INFO    ][30706] Volume keystone-keys already exists and is started.
2017-10-25 15:57:20,458 [salt.state       ][INFO    ][30706] Completed state [keystone-keys] at time 15:57:20.458231 duration_in_ms=116.121
2017-10-25 15:57:20,461 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 15:57:20.460967
2017-10-25 15:57:20,461 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-25 15:57:20,462 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 15:57:20,511 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:20,511 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 15:57:20.511180 duration_in_ms=50.213
2017-10-25 15:57:20,512 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:57:20.511616
2017-10-25 15:57:20,512 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 15:57:20,512 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 15:57:20,559 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:20,559 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:57:20.559105 duration_in_ms=47.488
2017-10-25 15:57:20,560 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:57:20.559581
2017-10-25 15:57:20,560 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 15:57:20,560 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 15:57:20,608 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:20,608 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:57:20.607931 duration_in_ms=48.35
2017-10-25 15:57:20,608 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 15:57:20.608403
2017-10-25 15:57:20,609 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-25 15:57:20,609 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 15:57:20,656 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:20,657 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 15:57:20.656608 duration_in_ms=48.204
2017-10-25 15:57:20,657 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 15:57:20.657087
2017-10-25 15:57:20,657 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-25 15:57:20,658 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 15:57:20,705 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:20,705 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 15:57:20.705296 duration_in_ms=48.208
2017-10-25 15:57:20,706 [salt.state       ][INFO    ][30706] Running state [keystone-keys] at time 15:57:20.706271
2017-10-25 15:57:20,707 [salt.state       ][INFO    ][30706] Executing state glusterfs.started for keystone-keys
2017-10-25 15:57:20,707 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:20,717 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:20,767 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:20,776 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:20,828 [salt.state       ][INFO    ][30706] Volume keystone-keys is already started
2017-10-25 15:57:20,828 [salt.state       ][INFO    ][30706] Completed state [keystone-keys] at time 15:57:20.828392 duration_in_ms=122.12
2017-10-25 15:57:20,829 [salt.state       ][INFO    ][30706] Running state [nova_instances] at time 15:57:20.829169
2017-10-25 15:57:20,829 [salt.state       ][INFO    ][30706] Executing state glusterfs.created for nova_instances
2017-10-25 15:57:20,830 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:20,839 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:20,887 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:20,895 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:20,946 [salt.state       ][INFO    ][30706] Volume nova_instances already exists and is started.
2017-10-25 15:57:20,946 [salt.state       ][INFO    ][30706] Completed state [nova_instances] at time 15:57:20.945725 duration_in_ms=116.554
2017-10-25 15:57:20,949 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 15:57:20.948683
2017-10-25 15:57:20,949 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 15:57:20,949 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 15:57:20,998 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:20,998 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 15:57:20.998248 duration_in_ms=49.565
2017-10-25 15:57:20,999 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 15:57:20.998652
2017-10-25 15:57:20,999 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-25 15:57:20,999 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-25 15:57:21,047 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:21,047 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 15:57:21.046888 duration_in_ms=48.235
2017-10-25 15:57:21,047 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 15:57:21.047334
2017-10-25 15:57:21,048 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-25 15:57:21,048 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-25 15:57:21,095 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:21,096 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 15:57:21.095554 duration_in_ms=48.219
2017-10-25 15:57:21,096 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 15:57:21.095962
2017-10-25 15:57:21,096 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-25 15:57:21,097 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-25 15:57:21,148 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:21,148 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 15:57:21.148366 duration_in_ms=52.404
2017-10-25 15:57:21,149 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 15:57:21.148805
2017-10-25 15:57:21,149 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 15:57:21,149 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 15:57:21,199 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:21,199 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 15:57:21.198876 duration_in_ms=50.071
2017-10-25 15:57:21,200 [salt.state       ][INFO    ][30706] Running state [nova_instances] at time 15:57:21.199794
2017-10-25 15:57:21,200 [salt.state       ][INFO    ][30706] Executing state glusterfs.started for nova_instances
2017-10-25 15:57:21,200 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:21,209 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:21,256 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:21,264 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:21,316 [salt.state       ][INFO    ][30706] Volume nova_instances is already started
2017-10-25 15:57:21,316 [salt.state       ][INFO    ][30706] Completed state [nova_instances] at time 15:57:21.316106 duration_in_ms=116.312
2017-10-25 15:57:21,317 [salt.state       ][INFO    ][30706] Running state [keystone-credential-keys] at time 15:57:21.316971
2017-10-25 15:57:21,317 [salt.state       ][INFO    ][30706] Executing state glusterfs.created for keystone-credential-keys
2017-10-25 15:57:21,318 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:21,326 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:21,374 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:21,382 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:21,433 [salt.state       ][INFO    ][30706] Volume keystone-credential-keys already exists and is started.
2017-10-25 15:57:21,434 [salt.state       ][INFO    ][30706] Completed state [keystone-credential-keys] at time 15:57:21.433503 duration_in_ms=116.532
2017-10-25 15:57:21,436 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 15:57:21.436454
2017-10-25 15:57:21,437 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-25 15:57:21,437 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 15:57:21,486 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:21,486 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 15:57:21.485939 duration_in_ms=49.485
2017-10-25 15:57:21,486 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:57:21.486399
2017-10-25 15:57:21,487 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 15:57:21,487 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 15:57:21,535 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:21,535 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:57:21.534842 duration_in_ms=48.443
2017-10-25 15:57:21,535 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 15:57:21.535343
2017-10-25 15:57:21,536 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-25 15:57:21,536 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 15:57:21,586 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:21,586 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 15:57:21.585708 duration_in_ms=50.364
2017-10-25 15:57:21,586 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:57:21.586152
2017-10-25 15:57:21,586 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 15:57:21,587 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 15:57:21,634 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:21,634 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:57:21.633930 duration_in_ms=47.777
2017-10-25 15:57:21,634 [salt.state       ][INFO    ][30706] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 15:57:21.634430
2017-10-25 15:57:21,635 [salt.state       ][INFO    ][30706] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-25 15:57:21,635 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 15:57:21,682 [salt.state       ][INFO    ][30706] unless execution succeeded
2017-10-25 15:57:21,682 [salt.state       ][INFO    ][30706] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 15:57:21.681892 duration_in_ms=47.462
2017-10-25 15:57:21,683 [salt.state       ][INFO    ][30706] Running state [keystone-credential-keys] at time 15:57:21.682870
2017-10-25 15:57:21,683 [salt.state       ][INFO    ][30706] Executing state glusterfs.started for keystone-credential-keys
2017-10-25 15:57:21,684 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:21,692 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:21,740 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --version' in directory '/root'
2017-10-25 15:57:21,750 [salt.loaded.int.module.cmdmod][INFO    ][30706] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 15:57:21,801 [salt.state       ][INFO    ][30706] Volume keystone-credential-keys is already started
2017-10-25 15:57:21,801 [salt.state       ][INFO    ][30706] Completed state [keystone-credential-keys] at time 15:57:21.801140 duration_in_ms=118.27
2017-10-25 15:57:21,803 [salt.minion      ][INFO    ][30706] Returning information for job: 20171025155716940366
2017-10-25 15:57:26,842 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command test.ping with jid 20171025155726823996
2017-10-25 15:57:26,858 [salt.minion      ][INFO    ][31131] Starting a new job with PID 31131
2017-10-25 15:57:26,884 [salt.minion      ][INFO    ][31131] Returning information for job: 20171025155726823996
2017-10-25 15:57:27,277 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command cmd.run with jid 20171025155727259967
2017-10-25 15:57:27,292 [salt.minion      ][INFO    ][31136] Starting a new job with PID 31136
2017-10-25 15:57:27,296 [salt.loaded.int.module.cmdmod][INFO    ][31136] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-25 15:57:27,416 [salt.minion      ][INFO    ][31136] Returning information for job: 20171025155727259967
2017-10-25 16:11:44,858 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command test.ping with jid 20171025161144850192
2017-10-25 16:11:44,875 [salt.minion      ][INFO    ][31392] Starting a new job with PID 31392
2017-10-25 16:11:44,901 [salt.minion      ][INFO    ][31392] Returning information for job: 20171025161144850192
2017-10-25 16:11:53,985 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command state.sls with jid 20171025161153976678
2017-10-25 16:11:54,000 [salt.minion      ][INFO    ][31398] Starting a new job with PID 31398
2017-10-25 16:11:54,421 [salt.state       ][INFO    ][31398] Loading fresh modules for state activity
2017-10-25 16:11:54,446 [salt.fileclient  ][INFO    ][31398] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-25 16:11:54,462 [salt.fileclient  ][INFO    ][31398] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-25 16:11:54,486 [salt.fileclient  ][INFO    ][31398] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 16:11:54,748 [salt.state       ][INFO    ][31398] Running state [lsof] at time 16:11:54.747501
2017-10-25 16:11:54,748 [salt.state       ][INFO    ][31398] Executing state pkg.installed for lsof
2017-10-25 16:11:54,748 [salt.loaded.int.module.cmdmod][INFO    ][31398] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 16:11:55,034 [salt.state       ][INFO    ][31398] Package lsof is already installed
2017-10-25 16:11:55,034 [salt.state       ][INFO    ][31398] Completed state [lsof] at time 16:11:55.034037 duration_in_ms=286.535
2017-10-25 16:11:55,034 [salt.state       ][INFO    ][31398] Running state [keepalived] at time 16:11:55.034236
2017-10-25 16:11:55,034 [salt.state       ][INFO    ][31398] Executing state pkg.installed for keepalived
2017-10-25 16:11:55,037 [salt.state       ][INFO    ][31398] Package keepalived is already installed
2017-10-25 16:11:55,037 [salt.state       ][INFO    ][31398] Completed state [keepalived] at time 16:11:55.037050 duration_in_ms=2.813
2017-10-25 16:11:55,038 [salt.state       ][INFO    ][31398] Running state [/etc/keepalived/keepalived.conf] at time 16:11:55.038402
2017-10-25 16:11:55,039 [salt.state       ][INFO    ][31398] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-25 16:11:55,060 [salt.fileclient  ][INFO    ][31398] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-25 16:11:55,088 [salt.fileclient  ][INFO    ][31398] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 16:11:55,092 [salt.state       ][INFO    ][31398] File /etc/keepalived/keepalived.conf is in the correct state
2017-10-25 16:11:55,092 [salt.state       ][INFO    ][31398] Completed state [/etc/keepalived/keepalived.conf] at time 16:11:55.092188 duration_in_ms=53.785
2017-10-25 16:11:55,093 [salt.state       ][INFO    ][31398] Running state [keepalived] at time 16:11:55.092658
2017-10-25 16:11:55,093 [salt.state       ][INFO    ][31398] Executing state service.running for keepalived
2017-10-25 16:11:55,093 [salt.loaded.int.module.cmdmod][INFO    ][31398] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-25 16:11:55,111 [salt.loaded.int.module.cmdmod][INFO    ][31398] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-25 16:11:55,120 [salt.loaded.int.module.cmdmod][INFO    ][31398] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-25 16:11:55,127 [salt.state       ][INFO    ][31398] The service keepalived is already running
2017-10-25 16:11:55,127 [salt.state       ][INFO    ][31398] Completed state [keepalived] at time 16:11:55.127258 duration_in_ms=34.599
2017-10-25 16:11:55,128 [salt.minion      ][INFO    ][31398] Returning information for job: 20171025161153976678
2017-10-25 16:12:13,018 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command pillar.get with jid 20171025161213010705
2017-10-25 16:12:13,036 [salt.minion      ][INFO    ][31426] Starting a new job with PID 31426
2017-10-25 16:12:13,040 [salt.minion      ][INFO    ][31426] Returning information for job: 20171025161213010705
2017-10-25 16:12:48,921 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command state.sls with jid 20171025161248917378
2017-10-25 16:12:48,937 [salt.minion      ][INFO    ][31436] Starting a new job with PID 31436
2017-10-25 16:12:49,373 [salt.state       ][INFO    ][31436] Loading fresh modules for state activity
2017-10-25 16:12:49,394 [salt.fileclient  ][INFO    ][31436] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-25 16:12:49,416 [salt.fileclient  ][INFO    ][31436] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 16:12:49,692 [salt.state       ][INFO    ][31436] Running state [attr] at time 16:12:49.692400
2017-10-25 16:12:49,693 [salt.state       ][INFO    ][31436] Executing state pkg.installed for attr
2017-10-25 16:12:49,693 [salt.loaded.int.module.cmdmod][INFO    ][31436] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 16:12:49,986 [salt.state       ][INFO    ][31436] Package attr is already installed
2017-10-25 16:12:49,986 [salt.state       ][INFO    ][31436] Completed state [attr] at time 16:12:49.986014 duration_in_ms=293.615
2017-10-25 16:12:49,986 [salt.state       ][INFO    ][31436] Running state [glusterfs-server] at time 16:12:49.986221
2017-10-25 16:12:49,986 [salt.state       ][INFO    ][31436] Executing state pkg.installed for glusterfs-server
2017-10-25 16:12:49,989 [salt.state       ][INFO    ][31436] Package glusterfs-server is already installed
2017-10-25 16:12:49,989 [salt.state       ][INFO    ][31436] Completed state [glusterfs-server] at time 16:12:49.989114 duration_in_ms=2.892
2017-10-25 16:12:49,989 [salt.state       ][INFO    ][31436] Running state [bc] at time 16:12:49.989257
2017-10-25 16:12:49,989 [salt.state       ][INFO    ][31436] Executing state pkg.installed for bc
2017-10-25 16:12:49,992 [salt.state       ][INFO    ][31436] Package bc is already installed
2017-10-25 16:12:49,992 [salt.state       ][INFO    ][31436] Completed state [bc] at time 16:12:49.992104 duration_in_ms=2.847
2017-10-25 16:12:49,993 [salt.state       ][INFO    ][31436] Running state [glusterfs-server] at time 16:12:49.992774
2017-10-25 16:12:49,993 [salt.state       ][INFO    ][31436] Executing state service.running for glusterfs-server
2017-10-25 16:12:49,993 [salt.loaded.int.module.cmdmod][INFO    ][31436] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-25 16:12:50,011 [salt.loaded.int.module.cmdmod][INFO    ][31436] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-25 16:12:50,020 [salt.loaded.int.module.cmdmod][INFO    ][31436] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-25 16:12:50,031 [salt.state       ][INFO    ][31436] The service glusterfs-server is already running
2017-10-25 16:12:50,031 [salt.state       ][INFO    ][31436] Completed state [glusterfs-server] at time 16:12:50.031191 duration_in_ms=38.418
2017-10-25 16:12:50,033 [salt.state       ][INFO    ][31436] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 16:12:50.032534
2017-10-25 16:12:50,033 [salt.state       ][INFO    ][31436] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-25 16:12:50,039 [salt.state       ][INFO    ][31436] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-25 16:12:50,039 [salt.state       ][INFO    ][31436] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 16:12:50.039270 duration_in_ms=6.737
2017-10-25 16:12:50,039 [salt.state       ][INFO    ][31436] Running state [/srv/glusterfs/glance] at time 16:12:50.039450
2017-10-25 16:12:50,040 [salt.state       ][INFO    ][31436] Executing state file.directory for /srv/glusterfs/glance
2017-10-25 16:12:50,040 [salt.state       ][INFO    ][31436] Directory /srv/glusterfs/glance is in the correct state
2017-10-25 16:12:50,040 [salt.state       ][INFO    ][31436] Completed state [/srv/glusterfs/glance] at time 16:12:50.040069 duration_in_ms=0.619
2017-10-25 16:12:50,040 [salt.state       ][INFO    ][31436] Running state [/srv/glusterfs/keystone-keys] at time 16:12:50.040215
2017-10-25 16:12:50,040 [salt.state       ][INFO    ][31436] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-25 16:12:50,041 [salt.state       ][INFO    ][31436] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-25 16:12:50,041 [salt.state       ][INFO    ][31436] Completed state [/srv/glusterfs/keystone-keys] at time 16:12:50.040796 duration_in_ms=0.582
2017-10-25 16:12:50,041 [salt.state       ][INFO    ][31436] Running state [/srv/glusterfs/nova_instances] at time 16:12:50.040939
2017-10-25 16:12:50,041 [salt.state       ][INFO    ][31436] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-25 16:12:50,041 [salt.state       ][INFO    ][31436] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-25 16:12:50,042 [salt.state       ][INFO    ][31436] Completed state [/srv/glusterfs/nova_instances] at time 16:12:50.041530 duration_in_ms=0.59
2017-10-25 16:12:50,042 [salt.state       ][INFO    ][31436] Running state [/srv/glusterfs/keystone-credential-keys] at time 16:12:50.041673
2017-10-25 16:12:50,042 [salt.state       ][INFO    ][31436] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-25 16:12:50,042 [salt.state       ][INFO    ][31436] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-25 16:12:50,042 [salt.state       ][INFO    ][31436] Completed state [/srv/glusterfs/keystone-credential-keys] at time 16:12:50.042240 duration_in_ms=0.567
2017-10-25 16:12:50,043 [salt.minion      ][INFO    ][31436] Returning information for job: 20171025161248917378
2017-10-25 16:12:51,181 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command test.ping with jid 20171025161251175923
2017-10-25 16:12:51,197 [salt.minion      ][INFO    ][31461] Starting a new job with PID 31461
2017-10-25 16:12:51,222 [salt.minion      ][INFO    ][31461] Returning information for job: 20171025161251175923
2017-10-25 16:12:56,117 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command state.sls with jid 20171025161256107960
2017-10-25 16:12:56,132 [salt.minion      ][INFO    ][31466] Starting a new job with PID 31466
2017-10-25 16:12:56,549 [salt.state       ][INFO    ][31466] Loading fresh modules for state activity
2017-10-25 16:12:56,571 [salt.fileclient  ][INFO    ][31466] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-25 16:12:56,604 [salt.fileclient  ][INFO    ][31466] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 16:12:56,668 [salt.fileclient  ][INFO    ][31466] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-25 16:12:56,686 [salt.fileclient  ][INFO    ][31466] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 16:12:56,951 [salt.state       ][INFO    ][31466] Running state [attr] at time 16:12:56.951283
2017-10-25 16:12:56,952 [salt.state       ][INFO    ][31466] Executing state pkg.installed for attr
2017-10-25 16:12:56,952 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 16:12:57,207 [salt.state       ][INFO    ][31466] Package attr is already installed
2017-10-25 16:12:57,208 [salt.state       ][INFO    ][31466] Completed state [attr] at time 16:12:57.207597 duration_in_ms=256.314
2017-10-25 16:12:57,208 [salt.state       ][INFO    ][31466] Running state [glusterfs-server] at time 16:12:57.207788
2017-10-25 16:12:57,208 [salt.state       ][INFO    ][31466] Executing state pkg.installed for glusterfs-server
2017-10-25 16:12:57,211 [salt.state       ][INFO    ][31466] Package glusterfs-server is already installed
2017-10-25 16:12:57,211 [salt.state       ][INFO    ][31466] Completed state [glusterfs-server] at time 16:12:57.210651 duration_in_ms=2.863
2017-10-25 16:12:57,211 [salt.state       ][INFO    ][31466] Running state [bc] at time 16:12:57.210790
2017-10-25 16:12:57,211 [salt.state       ][INFO    ][31466] Executing state pkg.installed for bc
2017-10-25 16:12:57,213 [salt.state       ][INFO    ][31466] Package bc is already installed
2017-10-25 16:12:57,214 [salt.state       ][INFO    ][31466] Completed state [bc] at time 16:12:57.213586 duration_in_ms=2.797
2017-10-25 16:12:57,214 [salt.state       ][INFO    ][31466] Running state [glusterfs-server] at time 16:12:57.214378
2017-10-25 16:12:57,215 [salt.state       ][INFO    ][31466] Executing state service.running for glusterfs-server
2017-10-25 16:12:57,215 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-25 16:12:57,233 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-25 16:12:57,241 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-25 16:12:57,252 [salt.state       ][INFO    ][31466] The service glusterfs-server is already running
2017-10-25 16:12:57,252 [salt.state       ][INFO    ][31466] Completed state [glusterfs-server] at time 16:12:57.251869 duration_in_ms=37.491
2017-10-25 16:12:57,254 [salt.state       ][INFO    ][31466] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 16:12:57.253527
2017-10-25 16:12:57,254 [salt.state       ][INFO    ][31466] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-25 16:12:57,266 [salt.state       ][INFO    ][31466] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-25 16:12:57,267 [salt.state       ][INFO    ][31466] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 16:12:57.266587 duration_in_ms=13.06
2017-10-25 16:12:57,267 [salt.state       ][INFO    ][31466] Running state [/srv/glusterfs/glance] at time 16:12:57.266784
2017-10-25 16:12:57,267 [salt.state       ][INFO    ][31466] Executing state file.directory for /srv/glusterfs/glance
2017-10-25 16:12:57,267 [salt.state       ][INFO    ][31466] Directory /srv/glusterfs/glance is in the correct state
2017-10-25 16:12:57,268 [salt.state       ][INFO    ][31466] Completed state [/srv/glusterfs/glance] at time 16:12:57.267530 duration_in_ms=0.745
2017-10-25 16:12:57,268 [salt.state       ][INFO    ][31466] Running state [/srv/glusterfs/keystone-keys] at time 16:12:57.267716
2017-10-25 16:12:57,268 [salt.state       ][INFO    ][31466] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-25 16:12:57,268 [salt.state       ][INFO    ][31466] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-25 16:12:57,268 [salt.state       ][INFO    ][31466] Completed state [/srv/glusterfs/keystone-keys] at time 16:12:57.268441 duration_in_ms=0.725
2017-10-25 16:12:57,269 [salt.state       ][INFO    ][31466] Running state [/srv/glusterfs/nova_instances] at time 16:12:57.268624
2017-10-25 16:12:57,269 [salt.state       ][INFO    ][31466] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-25 16:12:57,269 [salt.state       ][INFO    ][31466] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-25 16:12:57,269 [salt.state       ][INFO    ][31466] Completed state [/srv/glusterfs/nova_instances] at time 16:12:57.269355 duration_in_ms=0.73
2017-10-25 16:12:57,270 [salt.state       ][INFO    ][31466] Running state [/srv/glusterfs/keystone-credential-keys] at time 16:12:57.269545
2017-10-25 16:12:57,270 [salt.state       ][INFO    ][31466] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-25 16:12:57,270 [salt.state       ][INFO    ][31466] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-25 16:12:57,270 [salt.state       ][INFO    ][31466] Completed state [/srv/glusterfs/keystone-credential-keys] at time 16:12:57.270328 duration_in_ms=0.783
2017-10-25 16:12:57,314 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command ['git', '--version'] in directory '/root'
2017-10-25 16:12:57,397 [salt.state       ][INFO    ][31466] Running state [sleep 5] at time 16:12:57.396982
2017-10-25 16:12:57,397 [salt.state       ][INFO    ][31466] Executing state cmd.wait for sleep 5
2017-10-25 16:12:57,397 [salt.state       ][INFO    ][31466] No changes made for sleep 5
2017-10-25 16:12:57,398 [salt.state       ][INFO    ][31466] Completed state [sleep 5] at time 16:12:57.397544 duration_in_ms=0.563
2017-10-25 16:12:57,398 [salt.state       ][INFO    ][31466] Running state [10.167.4.141] at time 16:12:57.397928
2017-10-25 16:12:57,398 [salt.state       ][INFO    ][31466] Executing state glusterfs.peered for 10.167.4.141
2017-10-25 16:12:57,399 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:57,408 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:57,458 [salt.state       ][INFO    ][31466] Host 10.167.4.141 already peered
2017-10-25 16:12:57,458 [salt.state       ][INFO    ][31466] Completed state [10.167.4.141] at time 16:12:57.457884 duration_in_ms=59.955
2017-10-25 16:12:57,460 [salt.state       ][INFO    ][31466] Running state [10.167.4.142] at time 16:12:57.460122
2017-10-25 16:12:57,460 [salt.state       ][INFO    ][31466] Executing state glusterfs.peered for 10.167.4.142
2017-10-25 16:12:57,461 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:57,470 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:57,520 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:57,529 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:57,579 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:57,589 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:57,639 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:57,648 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:57,696 [salt.state       ][INFO    ][31466] Peering with localhost is not needed
2017-10-25 16:12:57,696 [salt.state       ][INFO    ][31466] Completed state [10.167.4.142] at time 16:12:57.695849 duration_in_ms=235.727
2017-10-25 16:12:57,698 [salt.state       ][INFO    ][31466] Running state [10.167.4.143] at time 16:12:57.698091
2017-10-25 16:12:57,698 [salt.state       ][INFO    ][31466] Executing state glusterfs.peered for 10.167.4.143
2017-10-25 16:12:57,699 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:57,708 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:57,756 [salt.state       ][INFO    ][31466] Host 10.167.4.143 already peered
2017-10-25 16:12:57,756 [salt.state       ][INFO    ][31466] Completed state [10.167.4.143] at time 16:12:57.755732 duration_in_ms=57.639
2017-10-25 16:12:57,757 [salt.state       ][INFO    ][31466] Running state [glance] at time 16:12:57.756602
2017-10-25 16:12:57,757 [salt.state       ][INFO    ][31466] Executing state glusterfs.created for glance
2017-10-25 16:12:57,757 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:57,766 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:57,815 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:57,824 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:57,877 [salt.state       ][INFO    ][31466] Volume glance already exists and is started.
2017-10-25 16:12:57,877 [salt.state       ][INFO    ][31466] Completed state [glance] at time 16:12:57.877195 duration_in_ms=120.593
2017-10-25 16:12:57,880 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 16:12:57.879878
2017-10-25 16:12:57,880 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 16:12:57,881 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 16:12:57,932 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:57,932 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 16:12:57.931878 duration_in_ms=51.999
2017-10-25 16:12:57,932 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 16:12:57.932306
2017-10-25 16:12:57,933 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-25 16:12:57,933 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 16:12:57,981 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:57,981 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 16:12:57.981125 duration_in_ms=48.819
2017-10-25 16:12:57,982 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 16:12:57.981553
2017-10-25 16:12:57,982 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-25 16:12:57,982 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 16:12:58,032 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:58,032 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 16:12:58.031818 duration_in_ms=50.266
2017-10-25 16:12:58,032 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 16:12:58.032222
2017-10-25 16:12:58,032 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 16:12:58,033 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 16:12:58,083 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:58,083 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 16:12:58.082706 duration_in_ms=50.483
2017-10-25 16:12:58,083 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 16:12:58.083143
2017-10-25 16:12:58,083 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-25 16:12:58,084 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 16:12:58,132 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:58,132 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 16:12:58.132101 duration_in_ms=48.957
2017-10-25 16:12:58,133 [salt.state       ][INFO    ][31466] Running state [glance] at time 16:12:58.133031
2017-10-25 16:12:58,133 [salt.state       ][INFO    ][31466] Executing state glusterfs.started for glance
2017-10-25 16:12:58,134 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:58,143 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:58,193 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:58,201 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:58,254 [salt.state       ][INFO    ][31466] Volume glance is already started
2017-10-25 16:12:58,254 [salt.state       ][INFO    ][31466] Completed state [glance] at time 16:12:58.253809 duration_in_ms=120.777
2017-10-25 16:12:58,255 [salt.state       ][INFO    ][31466] Running state [keystone-keys] at time 16:12:58.254636
2017-10-25 16:12:58,255 [salt.state       ][INFO    ][31466] Executing state glusterfs.created for keystone-keys
2017-10-25 16:12:58,255 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:58,265 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:58,312 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:58,321 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:58,385 [salt.state       ][INFO    ][31466] Volume keystone-keys already exists and is started.
2017-10-25 16:12:58,386 [salt.state       ][INFO    ][31466] Completed state [keystone-keys] at time 16:12:58.385603 duration_in_ms=130.967
2017-10-25 16:12:58,388 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 16:12:58.388364
2017-10-25 16:12:58,389 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-25 16:12:58,389 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 16:12:58,440 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:58,440 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 16:12:58.440055 duration_in_ms=51.69
2017-10-25 16:12:58,441 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 16:12:58.440480
2017-10-25 16:12:58,441 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 16:12:58,441 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 16:12:58,489 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:58,490 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 16:12:58.489561 duration_in_ms=49.081
2017-10-25 16:12:58,490 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 16:12:58.490069
2017-10-25 16:12:58,490 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 16:12:58,491 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 16:12:58,541 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:58,542 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 16:12:58.541622 duration_in_ms=51.553
2017-10-25 16:12:58,542 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 16:12:58.542092
2017-10-25 16:12:58,542 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-25 16:12:58,543 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 16:12:58,591 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:58,591 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 16:12:58.591168 duration_in_ms=49.075
2017-10-25 16:12:58,592 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 16:12:58.591607
2017-10-25 16:12:58,592 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-25 16:12:58,592 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 16:12:58,640 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:58,640 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 16:12:58.639865 duration_in_ms=48.257
2017-10-25 16:12:58,641 [salt.state       ][INFO    ][31466] Running state [keystone-keys] at time 16:12:58.640810
2017-10-25 16:12:58,641 [salt.state       ][INFO    ][31466] Executing state glusterfs.started for keystone-keys
2017-10-25 16:12:58,641 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:58,650 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:58,696 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:58,705 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:58,758 [salt.state       ][INFO    ][31466] Volume keystone-keys is already started
2017-10-25 16:12:58,758 [salt.state       ][INFO    ][31466] Completed state [keystone-keys] at time 16:12:58.758412 duration_in_ms=117.601
2017-10-25 16:12:58,759 [salt.state       ][INFO    ][31466] Running state [nova_instances] at time 16:12:58.759176
2017-10-25 16:12:58,759 [salt.state       ][INFO    ][31466] Executing state glusterfs.created for nova_instances
2017-10-25 16:12:58,760 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:58,768 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:58,815 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:58,824 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:58,875 [salt.state       ][INFO    ][31466] Volume nova_instances already exists and is started.
2017-10-25 16:12:58,876 [salt.state       ][INFO    ][31466] Completed state [nova_instances] at time 16:12:58.875499 duration_in_ms=116.322
2017-10-25 16:12:58,878 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 16:12:58.878393
2017-10-25 16:12:58,879 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 16:12:58,879 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 16:12:58,927 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:58,927 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 16:12:58.926897 duration_in_ms=48.502
2017-10-25 16:12:58,927 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 16:12:58.927376
2017-10-25 16:12:58,928 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-25 16:12:58,928 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-25 16:12:58,976 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:58,976 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 16:12:58.976123 duration_in_ms=48.746
2017-10-25 16:12:58,977 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 16:12:58.976599
2017-10-25 16:12:58,977 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-25 16:12:58,977 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-25 16:12:59,027 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:59,028 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 16:12:59.027584 duration_in_ms=50.984
2017-10-25 16:12:59,028 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 16:12:59.028029
2017-10-25 16:12:59,028 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-25 16:12:59,029 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-25 16:12:59,077 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:59,077 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 16:12:59.076934 duration_in_ms=48.904
2017-10-25 16:12:59,077 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 16:12:59.077379
2017-10-25 16:12:59,078 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 16:12:59,078 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 16:12:59,128 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:59,128 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 16:12:59.127721 duration_in_ms=50.341
2017-10-25 16:12:59,129 [salt.state       ][INFO    ][31466] Running state [nova_instances] at time 16:12:59.128589
2017-10-25 16:12:59,129 [salt.state       ][INFO    ][31466] Executing state glusterfs.started for nova_instances
2017-10-25 16:12:59,129 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:59,137 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:59,184 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:59,192 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:59,244 [salt.state       ][INFO    ][31466] Volume nova_instances is already started
2017-10-25 16:12:59,244 [salt.state       ][INFO    ][31466] Completed state [nova_instances] at time 16:12:59.244386 duration_in_ms=115.797
2017-10-25 16:12:59,245 [salt.state       ][INFO    ][31466] Running state [keystone-credential-keys] at time 16:12:59.245254
2017-10-25 16:12:59,245 [salt.state       ][INFO    ][31466] Executing state glusterfs.created for keystone-credential-keys
2017-10-25 16:12:59,246 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:59,254 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:59,303 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:59,311 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:59,361 [salt.state       ][INFO    ][31466] Volume keystone-credential-keys already exists and is started.
2017-10-25 16:12:59,362 [salt.state       ][INFO    ][31466] Completed state [keystone-credential-keys] at time 16:12:59.361562 duration_in_ms=116.308
2017-10-25 16:12:59,365 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 16:12:59.364472
2017-10-25 16:12:59,365 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-25 16:12:59,365 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 16:12:59,413 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:59,413 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 16:12:59.412854 duration_in_ms=48.382
2017-10-25 16:12:59,413 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 16:12:59.413297
2017-10-25 16:12:59,414 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 16:12:59,414 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 16:12:59,463 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:59,463 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 16:12:59.463117 duration_in_ms=49.819
2017-10-25 16:12:59,464 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 16:12:59.463530
2017-10-25 16:12:59,464 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-25 16:12:59,464 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 16:12:59,513 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:59,513 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 16:12:59.513089 duration_in_ms=49.558
2017-10-25 16:12:59,514 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 16:12:59.513519
2017-10-25 16:12:59,514 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 16:12:59,514 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 16:12:59,563 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:59,564 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 16:12:59.563544 duration_in_ms=50.025
2017-10-25 16:12:59,564 [salt.state       ][INFO    ][31466] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 16:12:59.563988
2017-10-25 16:12:59,564 [salt.state       ][INFO    ][31466] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-25 16:12:59,565 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 16:12:59,612 [salt.state       ][INFO    ][31466] unless execution succeeded
2017-10-25 16:12:59,613 [salt.state       ][INFO    ][31466] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 16:12:59.612648 duration_in_ms=48.66
2017-10-25 16:12:59,614 [salt.state       ][INFO    ][31466] Running state [keystone-credential-keys] at time 16:12:59.613558
2017-10-25 16:12:59,614 [salt.state       ][INFO    ][31466] Executing state glusterfs.started for keystone-credential-keys
2017-10-25 16:12:59,614 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:59,621 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:59,667 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --version' in directory '/root'
2017-10-25 16:12:59,676 [salt.loaded.int.module.cmdmod][INFO    ][31466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 16:12:59,728 [salt.state       ][INFO    ][31466] Volume keystone-credential-keys is already started
2017-10-25 16:12:59,728 [salt.state       ][INFO    ][31466] Completed state [keystone-credential-keys] at time 16:12:59.728203 duration_in_ms=114.645
2017-10-25 16:12:59,732 [salt.minion      ][INFO    ][31466] Returning information for job: 20171025161256107960
2017-10-25 16:13:04,689 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command test.ping with jid 20171025161304684971
2017-10-25 16:13:04,705 [salt.minion      ][INFO    ][31850] Starting a new job with PID 31850
2017-10-25 16:13:04,731 [salt.minion      ][INFO    ][31850] Returning information for job: 20171025161304684971
2017-10-25 16:13:05,130 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command cmd.run with jid 20171025161305121755
2017-10-25 16:13:05,145 [salt.minion      ][INFO    ][31855] Starting a new job with PID 31855
2017-10-25 16:13:05,149 [salt.loaded.int.module.cmdmod][INFO    ][31855] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-25 16:13:05,261 [salt.minion      ][INFO    ][31855] Returning information for job: 20171025161305121755
2017-10-25 16:37:05,111 [salt.utils.schedule][INFO    ][23414] Running scheduled job: __mine_interval
2017-10-25 17:20:18,810 [salt.minion      ][INFO    ][23414] User sudo_ubuntu Executing command cp.push_dir with jid 20171025172018800577
2017-10-25 17:20:18,830 [salt.minion      ][INFO    ][32604] Starting a new job with PID 32604
