2017-12-18 14:21:18,051 [salt.cli.daemons ][WARNING ][1967] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-18 14:25:25,379 [salt.state       ][ERROR   ][3272] No contents found in top file
2017-12-18 14:28:40,733 [salt.utils.parsers][WARNING ][1967] Minion received a SIGTERM. Exiting.
2017-12-18 14:30:54,570 [salt.cli.daemons ][WARNING ][2795] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-18 14:31:11,431 [py.warnings      ][WARNING ][2910] /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-12-18 14:31:54,353 [salt.loaded.int.module.cmdmod][ERROR   ][2910] 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-12-18 14:31:57,282 [salt.loaded.int.module.cmdmod][INFO    ][7417] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-18 14:31:57,295 [salt.loaded.int.module.cmdmod][INFO    ][7417] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-18 14:31:57,313 [salt.loaded.int.module.cmdmod][INFO    ][7417] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-18 14:31:57,328 [salt.utils.parsers][WARNING ][2795] Minion received a SIGTERM. Exiting.
2017-12-18 14:31:57,764 [salt.cli.daemons ][INFO    ][7500] Setting up the Salt Minion "kvm01.baremetal-mcp-pike-ovs-dpdk-ha.local"
2017-12-18 14:31:58,542 [salt.minion      ][INFO    ][7500] Creating minion process manager
2017-12-18 14:31:58,542 [salt.cli.daemons ][WARNING ][7500] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-18 14:31:58,542 [salt.cli.daemons ][INFO    ][7500] The Salt Minion is starting up
2017-12-18 14:31:58,542 [salt.minion      ][INFO    ][7500] Minion is starting as user 'root'
2017-12-18 14:31:58,543 [salt.utils.event ][INFO    ][7500] Starting pull socket on /var/run/salt/minion/minion_event_527cb3be15_pull.ipc
2017-12-18 14:31:59,714 [salt.loaded.int.module.cmdmod][INFO    ][7500] Executing command ['date', '+%z'] in directory '/root'
2017-12-18 14:31:59,728 [salt.utils.schedule][INFO    ][7500] Updating job settings for scheduled job: __mine_interval
2017-12-18 14:31:59,731 [salt.minion      ][INFO    ][7500] Added mine.update to scheduler
2017-12-18 14:31:59,768 [salt.minion      ][INFO    ][7500] Minion is ready to receive requests!
2017-12-18 14:32:00,769 [salt.utils.schedule][INFO    ][7500] Running scheduled job: __mine_interval
2017-12-18 14:32:07,931 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143207868016
2017-12-18 14:32:07,948 [salt.minion      ][INFO    ][7601] Starting a new job with PID 7601
2017-12-18 14:32:07,967 [salt.minion      ][INFO    ][7601] Returning information for job: 20171218143207868016
2017-12-18 14:32:18,053 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143217996761
2017-12-18 14:32:18,071 [salt.minion      ][INFO    ][7614] Starting a new job with PID 7614
2017-12-18 14:32:18,089 [salt.minion      ][INFO    ][7614] Returning information for job: 20171218143217996761
2017-12-18 14:32:28,266 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143228214141
2017-12-18 14:32:28,283 [salt.minion      ][INFO    ][7619] Starting a new job with PID 7619
2017-12-18 14:32:28,300 [salt.minion      ][INFO    ][7619] Returning information for job: 20171218143228214141
2017-12-18 14:32:39,599 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command state.sls with jid 20171218143239553449
2017-12-18 14:32:39,616 [salt.minion      ][INFO    ][7638] Starting a new job with PID 7638
2017-12-18 14:32:41,343 [salt.state       ][INFO    ][7638] Loading fresh modules for state activity
2017-12-18 14:32:41,387 [salt.fileclient  ][INFO    ][7638] Fetching file from saltenv 'base', ** done ** 'libvirt/init.sls'
2017-12-18 14:32:41,418 [salt.fileclient  ][INFO    ][7638] Fetching file from saltenv 'base', ** done ** 'libvirt/server/init.sls'
2017-12-18 14:32:41,436 [salt.fileclient  ][INFO    ][7638] Fetching file from saltenv 'base', ** done ** 'libvirt/server/service.sls'
2017-12-18 14:32:41,467 [salt.fileclient  ][INFO    ][7638] Fetching file from saltenv 'base', ** done ** 'libvirt/map.jinja'
2017-12-18 14:32:41,501 [salt.fileclient  ][INFO    ][7638] Fetching file from saltenv 'base', ** done ** 'libvirt/server/network.sls'
2017-12-18 14:32:41,535 [salt.fileclient  ][INFO    ][7638] Fetching file from saltenv 'base', ** done ** 'libvirt/map.jinja'
2017-12-18 14:32:41,561 [salt.fileclient  ][INFO    ][7638] Fetching file from saltenv 'base', ** done ** 'libvirt/server/pool.sls'
2017-12-18 14:32:41,589 [salt.fileclient  ][INFO    ][7638] Fetching file from saltenv 'base', ** done ** 'libvirt/map.jinja'
2017-12-18 14:32:41,933 [salt.state       ][INFO    ][7638] Running state [libvirt0] at time 14:32:41.932554
2017-12-18 14:32:41,933 [salt.state       ][INFO    ][7638] Executing state pkg.installed for libvirt0
2017-12-18 14:32:41,933 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 14:32:42,271 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-18 14:32:44,275 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'libvirt0'] in directory '/root'
2017-12-18 14:32:49,685 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143249643092
2017-12-18 14:32:49,703 [salt.minion      ][INFO    ][8083] Starting a new job with PID 8083
2017-12-18 14:32:49,724 [salt.minion      ][INFO    ][8083] Returning information for job: 20171218143249643092
2017-12-18 14:32:52,277 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 14:32:52,323 [salt.state       ][INFO    ][7638] Made the following changes:
'libvirt0' changed from 'absent' to '3.6.0-1ubuntu5~cloud0'
'libavahi-common-data' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2'
'libyajl2' changed from 'absent' to '2.1.0-2'
'libavahi-common3' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2'
'libxen-4.6' changed from 'absent' to '4.6.5-0ubuntu1.4'
'libxenstore3.0' changed from 'absent' to '4.6.5-0ubuntu1.4'
'libavahi-client3' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2'

2017-12-18 14:32:52,341 [salt.state       ][INFO    ][7638] Loading fresh modules for state activity
2017-12-18 14:32:52,369 [salt.state       ][INFO    ][7638] Completed state [libvirt0] at time 14:32:52.368832 duration_in_ms=10436.277
2017-12-18 14:32:52,379 [salt.state       ][INFO    ][7638] Running state [pm-utils] at time 14:32:52.378464
2017-12-18 14:32:52,379 [salt.state       ][INFO    ][7638] Executing state pkg.installed for pm-utils
2017-12-18 14:32:52,626 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'pm-utils'] in directory '/root'
2017-12-18 14:32:57,105 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 14:32:57,153 [salt.state       ][INFO    ][7638] Made the following changes:
'pm-utils' changed from 'absent' to '1.4.1-16'
'libx86-1' changed from 'absent' to '1.1+ds1-10'
'vbetool' changed from 'absent' to '1.1-3'

2017-12-18 14:32:57,169 [salt.state       ][INFO    ][7638] Loading fresh modules for state activity
2017-12-18 14:32:57,197 [salt.state       ][INFO    ][7638] Completed state [pm-utils] at time 14:32:57.196674 duration_in_ms=4818.21
2017-12-18 14:32:57,204 [salt.state       ][INFO    ][7638] Running state [python-libvirt] at time 14:32:57.204301
2017-12-18 14:32:57,205 [salt.state       ][INFO    ][7638] Executing state pkg.installed for python-libvirt
2017-12-18 14:32:57,447 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'python-libvirt'] in directory '/root'
2017-12-18 14:32:59,889 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143259853783
2017-12-18 14:32:59,906 [salt.minion      ][INFO    ][8773] Starting a new job with PID 8773
2017-12-18 14:32:59,926 [salt.minion      ][INFO    ][8773] Returning information for job: 20171218143259853783
2017-12-18 14:33:09,929 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143309898883
2017-12-18 14:33:09,947 [salt.minion      ][INFO    ][9011] Starting a new job with PID 9011
2017-12-18 14:33:09,973 [salt.minion      ][INFO    ][9011] Returning information for job: 20171218143309898883
2017-12-18 14:33:20,151 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143320126157
2017-12-18 14:33:20,168 [salt.minion      ][INFO    ][9876] Starting a new job with PID 9876
2017-12-18 14:33:20,186 [salt.minion      ][INFO    ][9876] Returning information for job: 20171218143320126157
2017-12-18 14:33:28,611 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 14:33:28,661 [salt.state       ][INFO    ][7638] Made the following changes:
'libbluetooth3' changed from 'absent' to '5.37-0ubuntu5.1'
'libvirt-daemon' changed from 'absent' to '3.6.0-1ubuntu5~cloud0'
'libpixman-1-0' changed from 'absent' to '0.33.6-1'
'qemu-system-x86-64' changed from 'absent' to '1'
'libnspr4' changed from 'absent' to '2:4.13.1-0ubuntu0.16.04.1'
'qemu-kvm' changed from 'absent' to '1:2.10+dfsg-0ubuntu3.1~cloud0'
'libnl-route-3-200' changed from 'absent' to '3.2.27-1ubuntu0.16.04.1'
'qemu-kvm-spice' changed from 'absent' to '1'
'librbd1' changed from 'absent' to '12.2.0-0ubuntu1~cloud0'
'libasound2' changed from 'absent' to '1.1.0-0ubuntu1'
'libjpeg-turbo8' changed from 'absent' to '1.4.2-0ubuntu3'
'python-libvirt' changed from 'absent' to '3.5.0-1build1~cloud0'
'libnss3' changed from 'absent' to '2:3.28.4-0ubuntu0.16.04.3'
'libasyncns0' changed from 'absent' to '0.8-5build1'
'libaugeas0' changed from 'absent' to '1.4.0-0ubuntu1.1'
'libsdl1.2debian' changed from 'absent' to '1.2.15+dfsg1-3'
'libpciaccess0' changed from 'absent' to '0.13.4-1'
'libiscsi2' changed from 'absent' to '1.12.0-2'
'libfdt1' changed from 'absent' to '1.4.2-1~cloud0'
'libvorbisenc2' changed from 'absent' to '1.3.5-3'
'augeas-lenses' changed from 'absent' to '1.4.0-0ubuntu1.1'
'librados2' changed from 'absent' to '12.2.0-0ubuntu1~cloud0'
'qemu-system-x86' changed from 'absent' to '1:2.10+dfsg-0ubuntu3.1~cloud0'
'msr-tools' changed from 'absent' to '1.3-2'
'ipxe-qemu' changed from 'absent' to '1.0.0+git-20150424.a25a16d-1ubuntu1.2'
'libogg0' changed from 'absent' to '1.3.2-1'
'libsndfile1' changed from 'absent' to '1.0.25-10ubuntu0.16.04.1'
'libasound2-data' changed from 'absent' to '1.1.0-0ubuntu1'
'libaio1' changed from 'absent' to '0.3.110-2'
'seabios' changed from 'absent' to '1.10.2-1ubuntu1~cloud0'
'libxml2-utils' changed from 'absent' to '2.9.3+dfsg1-1ubuntu0.5'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'qemu-block-extra' changed from 'absent' to '1:2.10+dfsg-0ubuntu3.1~cloud0'
'libvorbis0a' changed from 'absent' to '1.3.5-3'
'kvm' changed from 'absent' to '1'
'libspice-server1' changed from 'absent' to '0.12.6-4ubuntu0.3'
'qemu-utils' changed from 'absent' to '1:2.10+dfsg-0ubuntu3.1~cloud0'
'libcacard0' changed from 'absent' to '1:2.5.0-2'
'libcaca0' changed from 'absent' to '0.99.beta19-2build2~gcc5.2'
'libnss3-nssdb' changed from 'absent' to '2:3.28.4-0ubuntu0.16.04.3'
'qemu-keymaps' changed from 'absent' to '1'
'libbrlapi0.6' changed from 'absent' to '5.3.1-2ubuntu2.1'
'libpulse0' changed from 'absent' to '1:8.0-0ubuntu3.7'
'qemu-system-common' changed from 'absent' to '1:2.10+dfsg-0ubuntu3.1~cloud0'
'sharutils' changed from 'absent' to '1:4.15.2-1'
'qemu-system-i386' changed from 'absent' to '1'
'libnetcf1' changed from 'absent' to '1:0.2.8-1ubuntu1'
'libopus0' changed from 'absent' to '1.1.2-1ubuntu1'
'libjpeg8' changed from 'absent' to '8c-2ubuntu8'
'libusbredirparser1' changed from 'absent' to '0.7.1-1'
'libxslt1.1' changed from 'absent' to '1.1.28-2.1ubuntu0.1'
'libflac8' changed from 'absent' to '1.3.1-4'
'cpu-checker' changed from 'absent' to '0.7-0ubuntu7'

2017-12-18 14:33:28,677 [salt.state       ][INFO    ][7638] Loading fresh modules for state activity
2017-12-18 14:33:28,704 [salt.state       ][INFO    ][7638] Completed state [python-libvirt] at time 14:33:28.704139 duration_in_ms=31499.837
2017-12-18 14:33:28,712 [salt.state       ][INFO    ][7638] Running state [libvirt-bin] at time 14:33:28.712129
2017-12-18 14:33:28,712 [salt.state       ][INFO    ][7638] Executing state pkg.installed for libvirt-bin
2017-12-18 14:33:29,097 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'libvirt-bin'] in directory '/root'
2017-12-18 14:33:30,361 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143330341878
2017-12-18 14:33:30,380 [salt.minion      ][INFO    ][10162] Starting a new job with PID 10162
2017-12-18 14:33:30,403 [salt.minion      ][INFO    ][10162] Returning information for job: 20171218143330341878
2017-12-18 14:33:40,577 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143340560964
2017-12-18 14:33:40,595 [salt.minion      ][INFO    ][11045] Starting a new job with PID 11045
2017-12-18 14:33:40,618 [salt.minion      ][INFO    ][11045] Returning information for job: 20171218143340560964
2017-12-18 14:33:43,597 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 14:33:43,641 [salt.state       ][INFO    ][7638] Made the following changes:
'libvirt-daemon-system' changed from 'absent' to '3.6.0-1ubuntu5~cloud0'
'ebtables' changed from 'absent' to '2.0.10.4-3.4ubuntu2'
'libvirt-clients' changed from 'absent' to '3.6.0-1ubuntu5~cloud0'
'libvirt-bin' changed from 'absent' to '3.6.0-1ubuntu5~cloud0'

2017-12-18 14:33:43,666 [salt.state       ][INFO    ][7638] Loading fresh modules for state activity
2017-12-18 14:33:43,695 [salt.state       ][INFO    ][7638] Completed state [libvirt-bin] at time 14:33:43.694950 duration_in_ms=14982.82
2017-12-18 14:33:43,701 [salt.state       ][INFO    ][7638] Running state [qemu-utils] at time 14:33:43.701388
2017-12-18 14:33:43,702 [salt.state       ][INFO    ][7638] Executing state pkg.installed for qemu-utils
2017-12-18 14:33:43,923 [salt.state       ][INFO    ][7638] Package qemu-utils is already installed
2017-12-18 14:33:43,924 [salt.state       ][INFO    ][7638] Completed state [qemu-utils] at time 14:33:43.923594 duration_in_ms=222.205
2017-12-18 14:33:43,924 [salt.state       ][INFO    ][7638] Running state [qemu-kvm] at time 14:33:43.923772
2017-12-18 14:33:43,924 [salt.state       ][INFO    ][7638] Executing state pkg.installed for qemu-kvm
2017-12-18 14:33:43,927 [salt.state       ][INFO    ][7638] Package qemu-kvm is already installed
2017-12-18 14:33:43,927 [salt.state       ][INFO    ][7638] Completed state [qemu-kvm] at time 14:33:43.926774 duration_in_ms=3.002
2017-12-18 14:33:43,928 [salt.state       ][INFO    ][7638] Running state [/etc/libvirt/libvirtd.conf] at time 14:33:43.927968
2017-12-18 14:33:43,928 [salt.state       ][INFO    ][7638] Executing state file.managed for /etc/libvirt/libvirtd.conf
2017-12-18 14:33:43,949 [salt.fileclient  ][INFO    ][7638] Fetching file from saltenv 'base', ** done ** 'libvirt/files/libvirtd.conf.Debian'
2017-12-18 14:33:43,956 [salt.state       ][INFO    ][7638] File changed:
--- 
+++ 
@@ -32,6 +32,9 @@
 # This is disabled by default, uncomment this to enable it.
 #listen_tcp = 1
 
+listen_tls = 0
+listen_tcp = 1
+auth_tcp="none"
 
 
 # Override the port for accepting secure TLS connections
@@ -47,10 +50,6 @@
 
 # Override the default configuration which binds to all network
 # interfaces. This can be a numeric IPv4/6 address, or hostname
-#
-# If the libvirtd service is started in parallel with network
-# startup (e.g. with systemd), binding to addresses other than
-# the wildcards (0.0.0.0/::) might not be available yet.
 #
 #listen_addr = "192.168.0.1"
 
@@ -101,16 +100,8 @@
 # control, then you may want to relax this too.
 unix_sock_rw_perms = "0770"
 
-# Set the UNIX socket permissions for the admin interface socket.
-#
-# Default allows only owner (root), do not change it unless you are
-# sure to whom you are exposing the access to.
-#unix_sock_admin_perms = "0700"
-
 # Set the name of the directory in which sockets will be found/created.
 #unix_sock_dir = "/var/run/libvirt"
-
-
 
 #################################################################
 #
@@ -242,7 +233,7 @@
 #tls_allowed_dn_list = ["DN1", "DN2"]
 
 
-# A whitelist of allowed SASL usernames. The format for username
+# A whitelist of allowed SASL usernames. The format for usernames
 # depends on the SASL authentication mechanism. Kerberos usernames
 # look like username@REALM
 #
@@ -259,13 +250,6 @@
 #sasl_allowed_username_list = ["joe@EXAMPLE.COM", "fred@EXAMPLE.COM" ]
 
 
-# Override the compile time default TLS priority string. The
-# default is usually "NORMAL" unless overridden at build time.
-# Only set this is it is desired for libvirt to deviate from
-# the global default settings.
-#
-#tls_priority="NORMAL"
-
 
 #################################################################
 #
@@ -274,7 +258,7 @@
 
 # The maximum number of concurrent client connections to allow
 # over all sockets combined.
-#max_clients = 5000
+#max_clients = 20
 
 # The maximum length of queue of connections waiting to be
 # accepted by the daemon. Note, that some protocols supporting
@@ -282,10 +266,6 @@
 # connection succeeds.
 #max_queued_clients = 1000
 
-# The maximum length of queue of accepted but not yet
-# authenticated clients. The default value is 20. Set this to
-# zero to turn this feature off.
-#max_anonymous_clients = 20
 
 # The minimum limit sets the number of workers to start up
 # initially. If the number of active clients exceeds this,
@@ -317,16 +297,6 @@
 # and max_workers parameter
 #max_client_requests = 5
 
-# Same processing controls, but this time for the admin interface.
-# For description of each option, be so kind to scroll few lines
-# upwards.
-
-#admin_min_workers = 1
-#admin_max_workers = 5
-#admin_max_clients = 5
-#admin_max_queued_clients = 5
-#admin_max_client_requests = 5
-
 #################################################################
 #
 # Logging controls
@@ -334,10 +304,6 @@
 
 # Logging level: 4 errors, 3 warnings, 2 information, 1 debug
 # basically 1 will log everything possible
-# Note: Journald may employ rate limiting of the messages logged
-# and thus lock up the libvirt daemon. To use the debug level with
-# journald you have to specify it explicitly in 'log_outputs', otherwise
-# only information level messages will be logged.
 #log_level = 3
 
 # Logging filters:
@@ -346,16 +312,10 @@
 # The format for a filter is one of:
 #    x:name
 #    x:+name
-
-#      where name is a string which is matched against the category
-#      given in the VIR_LOG_INIT() at the top of each libvirt source
-#      file, e.g., "remote", "qemu", or "util.json" (the name in the
-#      filter can be a substring of the full category name, in order
-#      to match multiple similar categories), the optional "+" prefix
-#      tells libvirt to log stack trace for each message matching
-#      name, and x is the minimal level where matching messages should
-#      be logged:
-
+#      where name is a string which is matched against source file name,
+#      e.g., "remote", "qemu", or "util/json", the optional "+" prefix
+#      tells libvirt to log stack trace for each message matching name,
+#      and x is the minimal level where matching messages should be logged:
 #    1: DEBUG
 #    2: INFO
 #    3: WARNING
@@ -377,8 +337,6 @@
 #      use syslog for the output and use the given name as the ident
 #    x:file:file_path
 #      output to a file, with the given filepath
-#    x:journald
-#      output to journald logging system
 # In all case the x prefix is the minimal level, acting as a filter
 #    1: DEBUG
 #    2: INFO
@@ -390,11 +348,11 @@
 #log_outputs="3:syslog:libvirtd"
 #
 
-# Log debug buffer size:
-#
-# This configuration option is no longer used, since the global
-# log buffer functionality has been removed. Please configure
-# suitable log_outputs/log_filters settings to obtain logs.
+# Log debug buffer size: default 64
+# The daemon keeps an internal debug log buffer which will be dumped in case
+# of crash or upon receiving a SIGUSR2 signal. This setting allows to override
+# the default buffer size in kilobytes.
+# If value is 0 or less the debug log buffer is deactivated
 #log_buffer_size = 64
 
 
@@ -417,16 +375,10 @@
 
 ###################################################################
 # UUID of the host:
-# Host UUID is read from one of the sources specified in host_uuid_source.
-#
-# - 'smbios': fetch the UUID from 'dmidecode -s system-uuid'
-# - 'machine-id': fetch the UUID from /etc/machine-id
-#
-# The host_uuid_source default is 'smbios'. If 'dmidecode' does not provide
-# a valid UUID a temporary UUID will be generated.
-#
-# Another option is to specify host UUID in host_uuid.
-#
+# Provide the UUID of the host here in case the command
+# 'dmidecode -s system-uuid' does not provide a valid uuid. In case
+# 'dmidecode' does not provide a valid UUID and none is provided here, a
+# temporary UUID will be generated.
 # Keep the format of the example UUID below. UUID must not have all digits
 # be the same.
 
@@ -434,7 +386,6 @@
 # it with the output of the 'uuidgen' command and then
 # uncomment this entry
 #host_uuid = "00000000-0000-0000-0000-000000000000"
-#host_uuid_source = "smbios"
 
 ###################################################################
 # Keepalive protocol:
@@ -455,24 +406,8 @@
 #
 #keepalive_interval = 5
 #keepalive_count = 5
-
-#
-# These configuration options are no longer used.  There is no way to
-# restrict such clients from connecting since they first need to
-# connect in order to ask for keepalive.
+#
+# If set to 1, libvirtd will refuse to talk to clients that do not
+# support keepalive protocol.  Defaults to 0.
 #
 #keepalive_required = 1
-#admin_keepalive_required = 1
-
-# Keepalive settings for the admin interface
-#admin_keepalive_interval = 5
-#admin_keepalive_count = 5
-
-###################################################################
-# Open vSwitch:
-# This allows to specify a timeout for openvswitch calls made by
-# libvirt. The ovs-vsctl utility is used for the configuration and
-# its timeout option is set by default to 5 seconds to avoid
-# potential infinite waits blocking libvirt.
-#
-#ovs_timeout = 5

2017-12-18 14:33:43,956 [salt.state       ][INFO    ][7638] Completed state [/etc/libvirt/libvirtd.conf] at time 14:33:43.956283 duration_in_ms=28.315
2017-12-18 14:33:43,957 [salt.state       ][INFO    ][7638] Running state [/etc/default/libvirt-bin] at time 14:33:43.956516
2017-12-18 14:33:43,957 [salt.state       ][INFO    ][7638] Executing state file.managed for /etc/default/libvirt-bin
2017-12-18 14:33:43,970 [salt.fileclient  ][INFO    ][7638] Fetching file from saltenv 'base', ** done ** 'libvirt/files/libvirt-bin'
2017-12-18 14:33:43,973 [salt.state       ][INFO    ][7638] File changed:
New file
2017-12-18 14:33:43,973 [salt.state       ][INFO    ][7638] Completed state [/etc/default/libvirt-bin] at time 14:33:43.973191 duration_in_ms=16.675
2017-12-18 14:33:43,974 [salt.state       ][INFO    ][7638] Running state [service.systemctl_reload] at time 14:33:43.973814
2017-12-18 14:33:43,974 [salt.state       ][INFO    ][7638] Executing state module.wait for service.systemctl_reload
2017-12-18 14:33:43,974 [salt.state       ][INFO    ][7638] No changes made for service.systemctl_reload
2017-12-18 14:33:43,974 [salt.state       ][INFO    ][7638] Completed state [service.systemctl_reload] at time 14:33:43.974335 duration_in_ms=0.521
2017-12-18 14:33:43,974 [salt.state       ][INFO    ][7638] Running state [service.systemctl_reload] at time 14:33:43.974474
2017-12-18 14:33:43,975 [salt.state       ][INFO    ][7638] Executing state module.mod_watch for service.systemctl_reload
2017-12-18 14:33:43,975 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-18 14:33:44,091 [salt.state       ][INFO    ][7638] {'ret': True}
2017-12-18 14:33:44,091 [salt.state       ][INFO    ][7638] Completed state [service.systemctl_reload] at time 14:33:44.091095 duration_in_ms=116.62
2017-12-18 14:33:44,093 [salt.state       ][INFO    ][7638] Running state [/etc/libvirt/qemu/networks/default.xml] at time 14:33:44.093280
2017-12-18 14:33:44,094 [salt.state       ][INFO    ][7638] Executing state file.absent for /etc/libvirt/qemu/networks/default.xml
2017-12-18 14:33:44,094 [salt.state       ][INFO    ][7638] {'removed': '/etc/libvirt/qemu/networks/default.xml'}
2017-12-18 14:33:44,094 [salt.state       ][INFO    ][7638] Completed state [/etc/libvirt/qemu/networks/default.xml] at time 14:33:44.094226 duration_in_ms=0.945
2017-12-18 14:33:44,095 [salt.state       ][INFO    ][7638] Running state [libvirtd] at time 14:33:44.094746
2017-12-18 14:33:44,095 [salt.state       ][INFO    ][7638] Executing state service.running for libvirtd
2017-12-18 14:33:44,096 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['systemctl', 'status', 'libvirtd.service', '-n', '0'] in directory '/root'
2017-12-18 14:33:44,112 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['systemctl', 'is-active', 'libvirtd.service'] in directory '/root'
2017-12-18 14:33:44,125 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['systemctl', 'is-enabled', 'libvirtd.service'] in directory '/root'
2017-12-18 14:33:44,137 [salt.state       ][INFO    ][7638] The service libvirtd is already running
2017-12-18 14:33:44,138 [salt.state       ][INFO    ][7638] Completed state [libvirtd] at time 14:33:44.137531 duration_in_ms=42.783
2017-12-18 14:33:44,138 [salt.state       ][INFO    ][7638] Running state [libvirtd] at time 14:33:44.137901
2017-12-18 14:33:44,138 [salt.state       ][INFO    ][7638] Executing state service.mod_watch for libvirtd
2017-12-18 14:33:44,139 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['systemctl', 'is-active', 'libvirtd.service'] in directory '/root'
2017-12-18 14:33:44,151 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['systemctl', 'is-enabled', 'libvirtd.service'] in directory '/root'
2017-12-18 14:33:44,164 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'libvirtd.service'] in directory '/root'
2017-12-18 14:33:44,272 [salt.state       ][INFO    ][7638] {'libvirtd': True}
2017-12-18 14:33:44,272 [salt.state       ][INFO    ][7638] Completed state [libvirtd] at time 14:33:44.272166 duration_in_ms=134.264
2017-12-18 14:33:44,275 [salt.state       ][INFO    ][7638] Running state [virsh net-undefine default;virsh net-destroy default 2>&1 1>/dev/null] at time 14:33:44.274859
2017-12-18 14:33:44,275 [salt.state       ][INFO    ][7638] Executing state cmd.run for virsh net-undefine default;virsh net-destroy default 2>&1 1>/dev/null
2017-12-18 14:33:44,276 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command 'virsh -q net-list --all | grep -Eq '^\s*default'' in directory '/root'
2017-12-18 14:33:44,632 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command 'virsh net-undefine default;virsh net-destroy default 2>&1 1>/dev/null' in directory '/root'
2017-12-18 14:33:44,888 [salt.state       ][INFO    ][7638] {'pid': 11858, 'retcode': 0, 'stderr': "error: Failed to undefine network default\nerror: Requested operation is not valid: can't undefine transient network", 'stdout': ''}
2017-12-18 14:33:44,889 [salt.state       ][INFO    ][7638] Completed state [virsh net-undefine default;virsh net-destroy default 2>&1 1>/dev/null] at time 14:33:44.888417 duration_in_ms=613.558
2017-12-18 14:33:44,889 [salt.state       ][INFO    ][7638] Running state [virsh net-autostart default --disable] at time 14:33:44.888956
2017-12-18 14:33:44,889 [salt.state       ][INFO    ][7638] Executing state cmd.run for virsh net-autostart default --disable
2017-12-18 14:33:44,890 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command 'virsh net-info default | grep -Eq '^Autostart:\s+yes'' in directory '/root'
2017-12-18 14:33:44,923 [salt.state       ][INFO    ][7638] onlyif execution failed
2017-12-18 14:33:44,924 [salt.state       ][INFO    ][7638] Completed state [virsh net-autostart default --disable] at time 14:33:44.923766 duration_in_ms=34.809
2017-12-18 14:33:44,924 [salt.state       ][INFO    ][7638] Running state [virsh net-destroy default] at time 14:33:44.924305
2017-12-18 14:33:44,925 [salt.state       ][INFO    ][7638] Executing state cmd.run for virsh net-destroy default
2017-12-18 14:33:44,926 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command 'virsh -q net-list --all | grep -Eq '^\s*default\s+active'' in directory '/root'
2017-12-18 14:33:44,953 [salt.state       ][INFO    ][7638] onlyif execution failed
2017-12-18 14:33:44,953 [salt.state       ][INFO    ][7638] Completed state [virsh net-destroy default] at time 14:33:44.952936 duration_in_ms=28.631
2017-12-18 14:33:44,953 [salt.state       ][INFO    ][7638] Running state [echo 'No pool is defined'] at time 14:33:44.953411
2017-12-18 14:33:44,954 [salt.state       ][INFO    ][7638] Executing state cmd.run for echo 'No pool is defined'
2017-12-18 14:33:44,955 [salt.loaded.int.module.cmdmod][INFO    ][7638] Executing command 'echo 'No pool is defined'' in directory '/root'
2017-12-18 14:33:44,964 [salt.state       ][INFO    ][7638] {'pid': 11897, 'retcode': 0, 'stderr': '', 'stdout': 'No pool is defined'}
2017-12-18 14:33:44,965 [salt.state       ][INFO    ][7638] Completed state [echo 'No pool is defined'] at time 14:33:44.964458 duration_in_ms=11.047
2017-12-18 14:33:44,967 [salt.minion      ][INFO    ][7638] Returning information for job: 20171218143239553449
2017-12-18 14:33:55,033 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command state.apply with jid 20171218143355030482
2017-12-18 14:33:55,052 [salt.minion      ][INFO    ][11902] Starting a new job with PID 11902
2017-12-18 14:33:57,604 [salt.state       ][INFO    ][11902] Loading fresh modules for state activity
2017-12-18 14:33:57,643 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/init.sls'
2017-12-18 14:33:57,672 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-18 14:33:57,690 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-18 14:33:57,731 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-18 14:33:57,821 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-18 14:33:57,845 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-18 14:33:57,907 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-18 14:33:57,937 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-18 14:33:57,952 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-18 14:33:57,973 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-18 14:33:57,983 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-18 14:33:57,999 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-18 14:33:58,026 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-18 14:33:58,046 [py.warnings      ][WARNING ][11902] /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-12-18 14:33:58,046 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'salt-minion --version' in directory '/root'
2017-12-18 14:33:58,425 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'salt-minion --version' in directory '/root'
2017-12-18 14:33:58,824 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-18 14:33:58,850 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-18 14:33:58,867 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-18 14:33:58,884 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-18 14:33:58,948 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-18 14:33:58,966 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-18 14:33:58,995 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-18 14:33:59,013 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-18 14:33:59,038 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-18 14:33:59,087 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-18 14:33:59,178 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-18 14:33:59,204 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-18 14:33:59,278 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-18 14:33:59,301 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-18 14:33:59,362 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-18 14:33:59,407 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-18 14:33:59,427 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-18 14:33:59,468 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-18 14:33:59,483 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-18 14:33:59,501 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-18 14:33:59,531 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-18 14:33:59,648 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'salt-minion --version' in directory '/root'
2017-12-18 14:34:00,025 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'salt-minion --version' in directory '/root'
2017-12-18 14:34:00,426 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-18 14:34:00,450 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-18 14:34:00,466 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-18 14:34:00,482 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-18 14:34:00,547 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-18 14:34:00,566 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-18 14:34:00,594 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-18 14:34:00,611 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-18 14:34:00,641 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-18 14:34:00,694 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-18 14:34:00,801 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-18 14:34:00,887 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-18 14:34:00,952 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-18 14:34:00,969 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-18 14:34:00,998 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-18 14:34:01,444 [salt.state       ][INFO    ][11902] Running state [salt-minion] at time 14:34:01.444383
2017-12-18 14:34:01,445 [salt.state       ][INFO    ][11902] Executing state pkg.installed for salt-minion
2017-12-18 14:34:01,445 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 14:34:01,756 [salt.state       ][INFO    ][11902] Package salt-minion is already installed
2017-12-18 14:34:01,757 [salt.state       ][INFO    ][11902] Completed state [salt-minion] at time 14:34:01.756470 duration_in_ms=312.087
2017-12-18 14:34:01,757 [salt.state       ][INFO    ][11902] Running state [salt_minion_dependency_packages] at time 14:34:01.756668
2017-12-18 14:34:01,757 [salt.state       ][INFO    ][11902] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-18 14:34:01,759 [salt.state       ][INFO    ][11902] All specified packages are already installed
2017-12-18 14:34:01,760 [salt.state       ][INFO    ][11902] Completed state [salt_minion_dependency_packages] at time 14:34:01.759598 duration_in_ms=2.929
2017-12-18 14:34:01,761 [salt.state       ][INFO    ][11902] Running state [/etc/salt/minion.d/minion.conf] at time 14:34:01.761205
2017-12-18 14:34:01,761 [salt.state       ][INFO    ][11902] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-18 14:34:01,784 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-18 14:34:01,828 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-18 14:34:01,870 [salt.fileclient  ][INFO    ][11902] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-18 14:34:01,902 [salt.state       ][INFO    ][11902] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-18 14:34:01,902 [salt.state       ][INFO    ][11902] Completed state [/etc/salt/minion.d/minion.conf] at time 14:34:01.902363 duration_in_ms=141.159
2017-12-18 14:34:01,903 [salt.state       ][INFO    ][11902] Running state [/etc/salt/minion.d/_virt.conf] at time 14:34:01.902617
2017-12-18 14:34:01,903 [salt.state       ][INFO    ][11902] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-18 14:34:01,906 [salt.state       ][INFO    ][11902] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-18 14:34:01,906 [salt.state       ][INFO    ][11902] Completed state [/etc/salt/minion.d/_virt.conf] at time 14:34:01.905867 duration_in_ms=3.249
2017-12-18 14:34:01,907 [salt.state       ][INFO    ][11902] Running state [salt-minion] at time 14:34:01.907142
2017-12-18 14:34:01,907 [salt.state       ][INFO    ][11902] Executing state service.running for salt-minion
2017-12-18 14:34:01,908 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-18 14:34:01,934 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-18 14:34:01,946 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-18 14:34:01,959 [salt.state       ][INFO    ][11902] The service salt-minion is already running
2017-12-18 14:34:01,959 [salt.state       ][INFO    ][11902] Completed state [salt-minion] at time 14:34:01.959170 duration_in_ms=52.027
2017-12-18 14:34:01,962 [salt.state       ][INFO    ][11902] Running state [/etc/salt/grains.d] at time 14:34:01.962371
2017-12-18 14:34:01,963 [salt.state       ][INFO    ][11902] Executing state file.directory for /etc/salt/grains.d
2017-12-18 14:34:01,964 [salt.state       ][INFO    ][11902] Directory /etc/salt/grains.d is in the correct state
2017-12-18 14:34:01,965 [salt.state       ][INFO    ][11902] Completed state [/etc/salt/grains.d] at time 14:34:01.964531 duration_in_ms=2.16
2017-12-18 14:34:01,966 [salt.state       ][INFO    ][11902] Running state [/etc/salt/grains] at time 14:34:01.965566
2017-12-18 14:34:01,966 [salt.state       ][INFO    ][11902] Executing state file.managed for /etc/salt/grains
2017-12-18 14:34:01,967 [salt.state       ][INFO    ][11902] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-18 14:34:01,967 [salt.state       ][INFO    ][11902] Completed state [/etc/salt/grains] at time 14:34:01.967072 duration_in_ms=1.505
2017-12-18 14:34:01,968 [salt.state       ][INFO    ][11902] Running state [/etc/salt/grains.d/placeholder] at time 14:34:01.967747
2017-12-18 14:34:01,968 [salt.state       ][INFO    ][11902] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-18 14:34:01,969 [salt.state       ][INFO    ][11902] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-18 14:34:01,969 [salt.state       ][INFO    ][11902] Completed state [/etc/salt/grains.d/placeholder] at time 14:34:01.969202 duration_in_ms=1.456
2017-12-18 14:34:01,970 [salt.state       ][INFO    ][11902] Running state [/etc/salt/grains.d/sphinx] at time 14:34:01.969877
2017-12-18 14:34:01,970 [salt.state       ][INFO    ][11902] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-18 14:34:01,985 [salt.state       ][INFO    ][11902] File changed:
--- 
+++ 
@@ -49,6 +49,7 @@
               - 10.167.4.141
               - 127.0.0.1
               - 192.168.11.12
+              - 192.168.122.1
         system:
           name: System
           param:

2017-12-18 14:34:01,985 [salt.state       ][INFO    ][11902] Completed state [/etc/salt/grains.d/sphinx] at time 14:34:01.985421 duration_in_ms=15.545
2017-12-18 14:34:01,986 [salt.state       ][INFO    ][11902] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 14:34:01.986199
2017-12-18 14:34:01,986 [salt.state       ][INFO    ][11902] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:34:01,987 [salt.state       ][INFO    ][11902] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:34:01,987 [salt.state       ][INFO    ][11902] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 14:34:01.986843 duration_in_ms=0.644
2017-12-18 14:34:01,987 [salt.state       ][INFO    ][11902] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 14:34:01.987011
2017-12-18 14:34:01,987 [salt.state       ][INFO    ][11902] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:34:01,988 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-12-18 14:34:02,141 [salt.state       ][INFO    ][11902] {'pid': 11972, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-18 14:34:02,142 [salt.state       ][INFO    ][11902] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 14:34:02.141502 duration_in_ms=154.489
2017-12-18 14:34:02,143 [salt.state       ][INFO    ][11902] Running state [/etc/salt/grains.d/dns_records] at time 14:34:02.142511
2017-12-18 14:34:02,143 [salt.state       ][INFO    ][11902] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-18 14:34:02,155 [salt.state       ][INFO    ][11902] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-18 14:34:02,155 [salt.state       ][INFO    ][11902] Completed state [/etc/salt/grains.d/dns_records] at time 14:34:02.155017 duration_in_ms=12.504
2017-12-18 14:34:02,157 [salt.state       ][INFO    ][11902] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 14:34:02.156572
2017-12-18 14:34:02,157 [salt.state       ][INFO    ][11902] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:34:02,158 [salt.state       ][INFO    ][11902] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:34:02,158 [salt.state       ][INFO    ][11902] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 14:34:02.157883 duration_in_ms=1.31
2017-12-18 14:34:02,159 [salt.state       ][INFO    ][11902] Running state [/etc/salt/grains.d/salt] at time 14:34:02.158621
2017-12-18 14:34:02,159 [salt.state       ][INFO    ][11902] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-18 14:34:02,167 [salt.state       ][INFO    ][11902] File /etc/salt/grains.d/salt is in the correct state
2017-12-18 14:34:02,167 [salt.state       ][INFO    ][11902] Completed state [/etc/salt/grains.d/salt] at time 14:34:02.166954 duration_in_ms=8.331
2017-12-18 14:34:02,168 [salt.state       ][INFO    ][11902] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 14:34:02.168377
2017-12-18 14:34:02,169 [salt.state       ][INFO    ][11902] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:34:02,169 [salt.state       ][INFO    ][11902] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:34:02,170 [salt.state       ][INFO    ][11902] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 14:34:02.169640 duration_in_ms=1.262
2017-12-18 14:34:02,173 [salt.state       ][INFO    ][11902] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 14:34:02.172715
2017-12-18 14:34:02,173 [salt.state       ][INFO    ][11902] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-18 14:34:02,174 [salt.state       ][INFO    ][11902] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-18 14:34:02,174 [salt.state       ][INFO    ][11902] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 14:34:02.173994 duration_in_ms=1.278
2017-12-18 14:34:02,174 [salt.state       ][INFO    ][11902] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 14:34:02.174350
2017-12-18 14:34:02,175 [salt.state       ][INFO    ][11902] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-18 14:34:02,178 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-12-18 14:34:02,191 [salt.state       ][INFO    ][11902] {'pid': 11974, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-18 14:34:02,191 [salt.state       ][INFO    ][11902] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 14:34:02.191305 duration_in_ms=16.955
2017-12-18 14:34:02,193 [salt.state       ][INFO    ][11902] Running state [mine.update] at time 14:34:02.192751
2017-12-18 14:34:02,193 [salt.state       ][INFO    ][11902] Executing state module.wait for mine.update
2017-12-18 14:34:02,194 [salt.state       ][INFO    ][11902] No changes made for mine.update
2017-12-18 14:34:02,194 [salt.state       ][INFO    ][11902] Completed state [mine.update] at time 14:34:02.193974 duration_in_ms=1.224
2017-12-18 14:34:02,194 [salt.state       ][INFO    ][11902] Running state [mine.update] at time 14:34:02.194274
2017-12-18 14:34:02,195 [salt.state       ][INFO    ][11902] Executing state module.mod_watch for mine.update
2017-12-18 14:34:02,728 [salt.state       ][INFO    ][11902] {'ret': True}
2017-12-18 14:34:02,728 [salt.state       ][INFO    ][11902] Completed state [mine.update] at time 14:34:02.728035 duration_in_ms=533.761
2017-12-18 14:34:02,729 [salt.state       ][INFO    ][11902] Running state [ca-certificates] at time 14:34:02.728529
2017-12-18 14:34:02,729 [salt.state       ][INFO    ][11902] Executing state pkg.installed for ca-certificates
2017-12-18 14:34:02,737 [salt.state       ][INFO    ][11902] Package ca-certificates is already installed
2017-12-18 14:34:02,738 [salt.state       ][INFO    ][11902] Completed state [ca-certificates] at time 14:34:02.737684 duration_in_ms=9.155
2017-12-18 14:34:02,739 [salt.state       ][INFO    ][11902] Running state [update-ca-certificates] at time 14:34:02.738936
2017-12-18 14:34:02,739 [salt.state       ][INFO    ][11902] Executing state cmd.wait for update-ca-certificates
2017-12-18 14:34:02,740 [salt.state       ][INFO    ][11902] No changes made for update-ca-certificates
2017-12-18 14:34:02,740 [salt.state       ][INFO    ][11902] Completed state [update-ca-certificates] at time 14:34:02.740229 duration_in_ms=1.293
2017-12-18 14:34:02,741 [salt.state       ][INFO    ][11902] Running state [libvirt-dev] at time 14:34:02.740590
2017-12-18 14:34:02,741 [salt.state       ][INFO    ][11902] Executing state pkg.installed for libvirt-dev
2017-12-18 14:34:02,761 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-18 14:34:05,026 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'libvirt-dev'] in directory '/root'
2017-12-18 14:34:05,089 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143405085246
2017-12-18 14:34:05,106 [salt.minion      ][INFO    ][12327] Starting a new job with PID 12327
2017-12-18 14:34:05,222 [salt.minion      ][INFO    ][12327] Returning information for job: 20171218143405085246
2017-12-18 14:34:15,184 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143415180598
2017-12-18 14:34:15,202 [salt.minion      ][INFO    ][12463] Starting a new job with PID 12463
2017-12-18 14:34:15,290 [salt.minion      ][INFO    ][12463] Returning information for job: 20171218143415180598
2017-12-18 14:34:25,247 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143425243936
2017-12-18 14:34:25,265 [salt.minion      ][INFO    ][12710] Starting a new job with PID 12710
2017-12-18 14:34:25,360 [salt.minion      ][INFO    ][12710] Returning information for job: 20171218143425243936
2017-12-18 14:34:35,315 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143435311600
2017-12-18 14:34:35,333 [salt.minion      ][INFO    ][17477] Starting a new job with PID 17477
2017-12-18 14:34:35,412 [salt.minion      ][INFO    ][17477] Returning information for job: 20171218143435311600
2017-12-18 14:34:36,255 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 14:34:36,373 [salt.state       ][INFO    ][11902] Made the following changes:
'build-essential' changed from 'absent' to '12.1ubuntu2'
'libgomp1' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'c++-compiler' changed from 'absent' to '1'
'cpp' changed from 'absent' to '4:5.3.1-1ubuntu1'
'libalgorithm-merge-perl' changed from 'absent' to '0.08-3'
'binutils-gold' changed from 'absent' to '1'
'libfakeroot' changed from 'absent' to '1.20.2-1ubuntu1'
'linux-libc-dev' changed from 'absent' to '4.4.0-104.127'
'gcc-5' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libubsan0' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libalgorithm-diff-xs-perl' changed from 'absent' to '0.04-4build1'
'gcc' changed from 'absent' to '4:5.3.1-1ubuntu1'
'make' changed from 'absent' to '4.1-6'
'libitm1' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'g++' changed from 'absent' to '4:5.3.1-1ubuntu1'
'libfile-fcntllock-perl' changed from 'absent' to '0.22-3'
'c-compiler' changed from 'absent' to '1'
'libquadmath0' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'cpp:any' changed from 'absent' to '1'
'libmpc3' changed from 'absent' to '1.0.3-1'
'dpkg-dev' changed from 'absent' to '1.18.4ubuntu1.3'
'libmpx0' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libstdc++-5-dev' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'g++-5' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libc-dev' changed from 'absent' to '1'
'make:any' changed from 'absent' to '1'
'libatomic1' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libtsan0' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libasan2' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libvirt-dev' changed from 'absent' to '3.6.0-1ubuntu5~cloud0'
'libstdc++-dev' changed from 'absent' to '1'
'libc6-dev' changed from 'absent' to '2.23-0ubuntu9'
'libdpkg-perl' changed from 'absent' to '1.18.4ubuntu1.3'
'libcilkrts5' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'elf-binutils' changed from 'absent' to '1'
'libxen-dev' changed from 'absent' to '4.6.5-0ubuntu1.4'
'manpages-dev' changed from 'absent' to '4.04-2'
'cpp-5' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'c++abi2-dev' changed from 'absent' to '1'
'libisl15' changed from 'absent' to '0.16.1-1'
'linux-kernel-headers' changed from 'absent' to '1'
'liblsan0' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'fakeroot' changed from 'absent' to '1.20.2-1ubuntu1'
'libc-dev-bin' changed from 'absent' to '2.23-0ubuntu9'
'libgcc-5-dev' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libcc1-0' changed from 'absent' to '5.4.0-6ubuntu1~16.04.5'
'libalgorithm-diff-perl' changed from 'absent' to '1.19.03-1'
'binutils' changed from 'absent' to '2.26.1-1ubuntu1~16.04.5'
'pkg-config' changed from 'absent' to '0.29.1-0ubuntu1'

2017-12-18 14:34:36,390 [salt.state       ][INFO    ][11902] Loading fresh modules for state activity
2017-12-18 14:34:36,417 [salt.state       ][INFO    ][11902] Completed state [libvirt-dev] at time 14:34:36.416659 duration_in_ms=33676.069
2017-12-18 14:34:36,424 [salt.state       ][INFO    ][11902] Running state [pkg-config] at time 14:34:36.424291
2017-12-18 14:34:36,425 [salt.state       ][INFO    ][11902] Executing state pkg.installed for pkg-config
2017-12-18 14:34:36,674 [salt.state       ][INFO    ][11902] Package pkg-config is already installed
2017-12-18 14:34:36,675 [salt.state       ][INFO    ][11902] Completed state [pkg-config] at time 14:34:36.674520 duration_in_ms=250.228
2017-12-18 14:34:36,675 [salt.state       ][INFO    ][11902] Running state [virtng.init] at time 14:34:36.674924
2017-12-18 14:34:36,675 [salt.state       ][INFO    ][11902] Executing state module.run for virtng.init
2017-12-18 14:34:36,716 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command ['git', '--version'] in directory '/root'
2017-12-18 14:34:36,762 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:34:45,369 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143445366855
2017-12-18 14:34:45,388 [salt.minion      ][INFO    ][17554] Starting a new job with PID 17554
2017-12-18 14:34:45,409 [salt.minion      ][INFO    ][17554] Returning information for job: 20171218143445366855
2017-12-18 14:34:55,425 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143455421263
2017-12-18 14:34:55,442 [salt.minion      ][INFO    ][17559] Starting a new job with PID 17559
2017-12-18 14:34:55,464 [salt.minion      ][INFO    ][17559] Returning information for job: 20171218143455421263
2017-12-18 14:35:05,652 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143505651632
2017-12-18 14:35:05,670 [salt.minion      ][INFO    ][17574] Starting a new job with PID 17574
2017-12-18 14:35:05,692 [salt.minion      ][INFO    ][17574] Returning information for job: 20171218143505651632
2017-12-18 14:35:11,425 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-18 14:35:11,462 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:11,519 [salt.loaded.int.module.cmdmod][ERROR   ][11902] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-18 14:35:11,520 [salt.loaded.int.module.cmdmod][ERROR   ][11902] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-18 14:35:11,521 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/prx01.baremetal-mcp-pike-ovs-dpdk-ha.local/system.qcow2' in directory '/root'
2017-12-18 14:35:11,540 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:11,551 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-18 14:35:12,653 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-18 14:35:13,340 [salt.loaded.ext.module.seedng][INFO    ][11902] salt-minion pre-installed on image, configuring as prx01.baremetal-mcp-pike-ovs-dpdk-ha.local
2017-12-18 14:35:13,377 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'mount -l' in directory '/root'
2017-12-18 14:35:13,400 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-18 14:35:14,009 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:15,151 [salt.state       ][INFO    ][11902] {'ret': True}
2017-12-18 14:35:15,152 [salt.state       ][INFO    ][11902] Completed state [virtng.init] at time 14:35:15.151826 duration_in_ms=38476.9
2017-12-18 14:35:15,153 [salt.state       ][INFO    ][11902] Running state [virt.set_autostart] at time 14:35:15.152625
2017-12-18 14:35:15,153 [salt.state       ][INFO    ][11902] Executing state module.run for virt.set_autostart
2017-12-18 14:35:15,159 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:35:15,195 [salt.state       ][INFO    ][11902] {'ret': True}
2017-12-18 14:35:15,196 [salt.state       ][INFO    ][11902] Completed state [virt.set_autostart] at time 14:35:15.195841 duration_in_ms=43.216
2017-12-18 14:35:15,196 [salt.state       ][INFO    ][11902] Running state [virtng.init] at time 14:35:15.196318
2017-12-18 14:35:15,197 [salt.state       ][INFO    ][11902] Executing state module.run for virtng.init
2017-12-18 14:35:15,201 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:35:15,867 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143515865328
2017-12-18 14:35:15,884 [salt.minion      ][INFO    ][18048] Starting a new job with PID 18048
2017-12-18 14:35:15,905 [salt.minion      ][INFO    ][18048] Returning information for job: 20171218143515865328
2017-12-18 14:35:17,915 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-18 14:35:17,926 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:17,935 [salt.loaded.int.module.cmdmod][ERROR   ][11902] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-18 14:35:17,936 [salt.loaded.int.module.cmdmod][ERROR   ][11902] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-18 14:35:17,936 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/mdb01.baremetal-mcp-pike-ovs-dpdk-ha.local/system.qcow2' in directory '/root'
2017-12-18 14:35:17,952 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:17,963 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-18 14:35:19,036 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-18 14:35:19,807 [salt.loaded.ext.module.seedng][INFO    ][11902] salt-minion pre-installed on image, configuring as mdb01.baremetal-mcp-pike-ovs-dpdk-ha.local
2017-12-18 14:35:19,888 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'mount -l' in directory '/root'
2017-12-18 14:35:19,910 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-18 14:35:21,889 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:22,805 [salt.state       ][INFO    ][11902] {'ret': True}
2017-12-18 14:35:22,805 [salt.state       ][INFO    ][11902] Completed state [virtng.init] at time 14:35:22.805134 duration_in_ms=7608.815
2017-12-18 14:35:22,806 [salt.state       ][INFO    ][11902] Running state [virt.set_autostart] at time 14:35:22.805868
2017-12-18 14:35:22,807 [salt.state       ][INFO    ][11902] Executing state module.run for virt.set_autostart
2017-12-18 14:35:22,812 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:35:22,850 [salt.state       ][INFO    ][11902] {'ret': True}
2017-12-18 14:35:22,851 [salt.state       ][INFO    ][11902] Completed state [virt.set_autostart] at time 14:35:22.850630 duration_in_ms=44.762
2017-12-18 14:35:22,851 [salt.state       ][INFO    ][11902] Running state [virtng.init] at time 14:35:22.851124
2017-12-18 14:35:22,852 [salt.state       ][INFO    ][11902] Executing state module.run for virtng.init
2017-12-18 14:35:22,857 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:35:26,088 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143526086536
2017-12-18 14:35:26,102 [salt.minion      ][INFO    ][18331] Starting a new job with PID 18331
2017-12-18 14:35:26,121 [salt.minion      ][INFO    ][18331] Returning information for job: 20171218143526086536
2017-12-18 14:35:26,325 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-18 14:35:26,342 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:26,355 [salt.loaded.int.module.cmdmod][ERROR   ][11902] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-18 14:35:26,356 [salt.loaded.int.module.cmdmod][ERROR   ][11902] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-18 14:35:26,357 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/ctl01.baremetal-mcp-pike-ovs-dpdk-ha.local/system.qcow2' in directory '/root'
2017-12-18 14:35:26,380 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:26,390 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-18 14:35:27,460 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-18 14:35:28,559 [salt.loaded.ext.module.seedng][INFO    ][11902] salt-minion pre-installed on image, configuring as ctl01.baremetal-mcp-pike-ovs-dpdk-ha.local
2017-12-18 14:35:28,597 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'mount -l' in directory '/root'
2017-12-18 14:35:28,702 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-18 14:35:30,165 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:31,060 [salt.state       ][INFO    ][11902] {'ret': True}
2017-12-18 14:35:31,061 [salt.state       ][INFO    ][11902] Completed state [virtng.init] at time 14:35:31.060768 duration_in_ms=8209.644
2017-12-18 14:35:31,061 [salt.state       ][INFO    ][11902] Running state [virt.set_autostart] at time 14:35:31.061231
2017-12-18 14:35:31,062 [salt.state       ][INFO    ][11902] Executing state module.run for virt.set_autostart
2017-12-18 14:35:31,065 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:35:31,100 [salt.state       ][INFO    ][11902] {'ret': True}
2017-12-18 14:35:31,101 [salt.state       ][INFO    ][11902] Completed state [virt.set_autostart] at time 14:35:31.100770 duration_in_ms=39.539
2017-12-18 14:35:31,101 [salt.state       ][INFO    ][11902] Running state [virtng.init] at time 14:35:31.101143
2017-12-18 14:35:31,101 [salt.state       ][INFO    ][11902] Executing state module.run for virtng.init
2017-12-18 14:35:31,105 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:35:36,315 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143536312093
2017-12-18 14:35:36,334 [salt.minion      ][INFO    ][18608] Starting a new job with PID 18608
2017-12-18 14:35:36,357 [salt.minion      ][INFO    ][18608] Returning information for job: 20171218143536312093
2017-12-18 14:35:40,090 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-18 14:35:40,107 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:40,120 [salt.loaded.int.module.cmdmod][ERROR   ][11902] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-18 14:35:40,198 [salt.loaded.int.module.cmdmod][ERROR   ][11902] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-18 14:35:40,199 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/msg01.baremetal-mcp-pike-ovs-dpdk-ha.local/system.qcow2' in directory '/root'
2017-12-18 14:35:40,221 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:40,235 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-18 14:35:41,308 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-18 14:35:42,106 [salt.loaded.ext.module.seedng][INFO    ][11902] salt-minion pre-installed on image, configuring as msg01.baremetal-mcp-pike-ovs-dpdk-ha.local
2017-12-18 14:35:42,139 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'mount -l' in directory '/root'
2017-12-18 14:35:42,161 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-18 14:35:42,772 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:43,569 [salt.state       ][INFO    ][11902] {'ret': True}
2017-12-18 14:35:43,570 [salt.state       ][INFO    ][11902] Completed state [virtng.init] at time 14:35:43.569508 duration_in_ms=12468.363
2017-12-18 14:35:43,570 [salt.state       ][INFO    ][11902] Running state [virt.set_autostart] at time 14:35:43.570109
2017-12-18 14:35:43,571 [salt.state       ][INFO    ][11902] Executing state module.run for virt.set_autostart
2017-12-18 14:35:43,576 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:35:43,613 [salt.state       ][INFO    ][11902] {'ret': True}
2017-12-18 14:35:43,614 [salt.state       ][INFO    ][11902] Completed state [virt.set_autostart] at time 14:35:43.613480 duration_in_ms=43.371
2017-12-18 14:35:43,614 [salt.state       ][INFO    ][11902] Running state [virtng.init] at time 14:35:43.613986
2017-12-18 14:35:43,614 [salt.state       ][INFO    ][11902] Executing state module.run for virtng.init
2017-12-18 14:35:43,619 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:35:46,333 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218143546330565
2017-12-18 14:35:46,349 [salt.minion      ][INFO    ][18883] Starting a new job with PID 18883
2017-12-18 14:35:46,369 [salt.minion      ][INFO    ][18883] Returning information for job: 20171218143546330565
2017-12-18 14:35:46,632 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-18 14:35:46,645 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:46,655 [salt.loaded.int.module.cmdmod][ERROR   ][11902] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-18 14:35:46,655 [salt.loaded.int.module.cmdmod][ERROR   ][11902] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-18 14:35:46,656 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/dbs01.baremetal-mcp-pike-ovs-dpdk-ha.local/system.qcow2' in directory '/root'
2017-12-18 14:35:46,672 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:46,683 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-18 14:35:47,752 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-18 14:35:48,572 [salt.loaded.ext.module.seedng][INFO    ][11902] salt-minion pre-installed on image, configuring as dbs01.baremetal-mcp-pike-ovs-dpdk-ha.local
2017-12-18 14:35:48,603 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'mount -l' in directory '/root'
2017-12-18 14:35:48,623 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-18 14:35:50,204 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-18 14:35:51,053 [salt.state       ][INFO    ][11902] {'ret': True}
2017-12-18 14:35:51,054 [salt.state       ][INFO    ][11902] Completed state [virtng.init] at time 14:35:51.053510 duration_in_ms=7439.523
2017-12-18 14:35:51,054 [salt.state       ][INFO    ][11902] Running state [virt.set_autostart] at time 14:35:51.054098
2017-12-18 14:35:51,055 [salt.state       ][INFO    ][11902] Executing state module.run for virt.set_autostart
2017-12-18 14:35:51,060 [salt.loaded.int.module.cmdmod][INFO    ][11902] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:35:51,096 [salt.state       ][INFO    ][11902] {'ret': True}
2017-12-18 14:35:51,097 [salt.state       ][INFO    ][11902] Completed state [virt.set_autostart] at time 14:35:51.096752 duration_in_ms=42.654
2017-12-18 14:35:51,101 [salt.minion      ][INFO    ][11902] Returning information for job: 20171218143355030482
2017-12-18 14:36:30,419 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command state.sls with jid 20171218143630416963
2017-12-18 14:36:30,437 [salt.minion      ][INFO    ][19159] Starting a new job with PID 19159
2017-12-18 14:36:32,915 [salt.state       ][INFO    ][19159] Loading fresh modules for state activity
2017-12-18 14:36:32,962 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-18 14:36:32,999 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-18 14:36:33,077 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-18 14:36:33,204 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-18 14:36:33,221 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-18 14:36:33,273 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-18 14:36:33,627 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-18 14:36:33,660 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-18 14:36:33,792 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-18 14:36:33,862 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-18 14:36:33,883 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-18 14:36:33,911 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-18 14:36:33,928 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-18 14:36:33,947 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-18 14:36:33,993 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-18 14:36:34,030 [py.warnings      ][WARNING ][19159] /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-12-18 14:36:34,031 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'salt-minion --version' in directory '/root'
2017-12-18 14:36:34,458 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'salt-minion --version' in directory '/root'
2017-12-18 14:36:34,846 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-18 14:36:34,872 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-18 14:36:34,889 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-18 14:36:34,906 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-18 14:36:34,975 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-18 14:36:35,018 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-18 14:36:35,082 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-18 14:36:35,102 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-18 14:36:35,165 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-18 14:36:35,214 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-18 14:36:35,327 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-18 14:36:35,368 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-18 14:36:35,477 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-18 14:36:35,507 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-18 14:36:35,609 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-18 14:36:35,645 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-18 14:36:35,703 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-18 14:36:35,731 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-18 14:36:35,747 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-18 14:36:35,765 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-18 14:36:35,795 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-18 14:36:35,823 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'salt-minion --version' in directory '/root'
2017-12-18 14:36:36,242 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'salt-minion --version' in directory '/root'
2017-12-18 14:36:36,609 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-18 14:36:36,636 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-18 14:36:36,653 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-18 14:36:36,671 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-18 14:36:36,739 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-18 14:36:36,758 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-18 14:36:36,787 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-18 14:36:36,805 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-18 14:36:36,831 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-18 14:36:36,874 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-18 14:36:36,973 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-18 14:36:37,069 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-18 14:36:37,461 [salt.state       ][INFO    ][19159] Running state [salt-minion] at time 14:36:37.461335
2017-12-18 14:36:37,462 [salt.state       ][INFO    ][19159] Executing state pkg.installed for salt-minion
2017-12-18 14:36:37,462 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 14:36:37,804 [salt.state       ][INFO    ][19159] Package salt-minion is already installed
2017-12-18 14:36:37,870 [salt.state       ][INFO    ][19159] Completed state [salt-minion] at time 14:36:37.870354 duration_in_ms=409.017
2017-12-18 14:36:37,871 [salt.state       ][INFO    ][19159] Running state [salt_minion_dependency_packages] at time 14:36:37.870933
2017-12-18 14:36:37,871 [salt.state       ][INFO    ][19159] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-18 14:36:37,879 [salt.state       ][INFO    ][19159] All specified packages are already installed
2017-12-18 14:36:37,880 [salt.state       ][INFO    ][19159] Completed state [salt_minion_dependency_packages] at time 14:36:37.879623 duration_in_ms=8.69
2017-12-18 14:36:37,884 [salt.state       ][INFO    ][19159] Running state [/etc/salt/minion.d/minion.conf] at time 14:36:37.883478
2017-12-18 14:36:37,884 [salt.state       ][INFO    ][19159] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-18 14:36:37,911 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-18 14:36:38,012 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-18 14:36:38,180 [salt.fileclient  ][INFO    ][19159] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-18 14:36:38,256 [salt.state       ][INFO    ][19159] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-18 14:36:38,256 [salt.state       ][INFO    ][19159] Completed state [/etc/salt/minion.d/minion.conf] at time 14:36:38.255994 duration_in_ms=372.516
2017-12-18 14:36:38,257 [salt.state       ][INFO    ][19159] Running state [/etc/salt/minion.d/_virt.conf] at time 14:36:38.256543
2017-12-18 14:36:38,257 [salt.state       ][INFO    ][19159] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-18 14:36:38,339 [salt.state       ][INFO    ][19159] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-18 14:36:38,339 [salt.state       ][INFO    ][19159] Completed state [/etc/salt/minion.d/_virt.conf] at time 14:36:38.339237 duration_in_ms=82.693
2017-12-18 14:36:38,343 [salt.state       ][INFO    ][19159] Running state [salt-minion] at time 14:36:38.343020
2017-12-18 14:36:38,343 [salt.state       ][INFO    ][19159] Executing state service.running for salt-minion
2017-12-18 14:36:38,344 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-18 14:36:38,373 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-18 14:36:38,386 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-18 14:36:38,398 [salt.state       ][INFO    ][19159] The service salt-minion is already running
2017-12-18 14:36:38,517 [salt.state       ][INFO    ][19159] Completed state [salt-minion] at time 14:36:38.516844 duration_in_ms=173.822
2017-12-18 14:36:38,520 [salt.state       ][INFO    ][19159] Running state [/etc/salt/grains.d] at time 14:36:38.520115
2017-12-18 14:36:38,521 [salt.state       ][INFO    ][19159] Executing state file.directory for /etc/salt/grains.d
2017-12-18 14:36:38,522 [salt.state       ][INFO    ][19159] Directory /etc/salt/grains.d is in the correct state
2017-12-18 14:36:38,522 [salt.state       ][INFO    ][19159] Completed state [/etc/salt/grains.d] at time 14:36:38.522342 duration_in_ms=2.226
2017-12-18 14:36:38,524 [salt.state       ][INFO    ][19159] Running state [/etc/salt/grains] at time 14:36:38.523496
2017-12-18 14:36:38,524 [salt.state       ][INFO    ][19159] Executing state file.managed for /etc/salt/grains
2017-12-18 14:36:38,525 [salt.state       ][INFO    ][19159] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-18 14:36:38,525 [salt.state       ][INFO    ][19159] Completed state [/etc/salt/grains] at time 14:36:38.525202 duration_in_ms=1.705
2017-12-18 14:36:38,526 [salt.state       ][INFO    ][19159] Running state [/etc/salt/grains.d/placeholder] at time 14:36:38.525997
2017-12-18 14:36:38,527 [salt.state       ][INFO    ][19159] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-18 14:36:38,527 [salt.state       ][INFO    ][19159] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-18 14:36:38,528 [salt.state       ][INFO    ][19159] Completed state [/etc/salt/grains.d/placeholder] at time 14:36:38.527650 duration_in_ms=1.652
2017-12-18 14:36:38,529 [salt.state       ][INFO    ][19159] Running state [/etc/salt/grains.d/sphinx] at time 14:36:38.528433
2017-12-18 14:36:38,529 [salt.state       ][INFO    ][19159] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-18 14:36:38,608 [salt.state       ][INFO    ][19159] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.141
               - 127.0.0.1
               - 192.168.11.12
-              - 192.168.122.1
         system:
           name: System
           param:

2017-12-18 14:36:38,609 [salt.state       ][INFO    ][19159] Completed state [/etc/salt/grains.d/sphinx] at time 14:36:38.608741 duration_in_ms=80.307
2017-12-18 14:36:38,610 [salt.state       ][INFO    ][19159] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 14:36:38.610333
2017-12-18 14:36:38,611 [salt.state       ][INFO    ][19159] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:36:38,611 [salt.state       ][INFO    ][19159] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:36:38,612 [salt.state       ][INFO    ][19159] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 14:36:38.611643 duration_in_ms=1.309
2017-12-18 14:36:38,612 [salt.state       ][INFO    ][19159] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 14:36:38.612032
2017-12-18 14:36:38,612 [salt.state       ][INFO    ][19159] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:36:38,614 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-12-18 14:36:38,755 [salt.state       ][INFO    ][19159] {'pid': 19234, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-18 14:36:38,756 [salt.state       ][INFO    ][19159] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 14:36:38.756030 duration_in_ms=143.998
2017-12-18 14:36:38,757 [salt.state       ][INFO    ][19159] Running state [/etc/salt/grains.d/dns_records] at time 14:36:38.756957
2017-12-18 14:36:38,757 [salt.state       ][INFO    ][19159] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-18 14:36:38,877 [salt.state       ][INFO    ][19159] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-18 14:36:38,877 [salt.state       ][INFO    ][19159] Completed state [/etc/salt/grains.d/dns_records] at time 14:36:38.877078 duration_in_ms=120.12
2017-12-18 14:36:38,879 [salt.state       ][INFO    ][19159] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 14:36:38.878515
2017-12-18 14:36:38,879 [salt.state       ][INFO    ][19159] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:36:38,879 [salt.state       ][INFO    ][19159] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:36:38,880 [salt.state       ][INFO    ][19159] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 14:36:38.879752 duration_in_ms=1.237
2017-12-18 14:36:38,881 [salt.state       ][INFO    ][19159] Running state [/etc/salt/grains.d/salt] at time 14:36:38.880457
2017-12-18 14:36:38,881 [salt.state       ][INFO    ][19159] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-18 14:36:39,031 [salt.state       ][INFO    ][19159] File /etc/salt/grains.d/salt is in the correct state
2017-12-18 14:36:39,032 [salt.state       ][INFO    ][19159] Completed state [/etc/salt/grains.d/salt] at time 14:36:39.031795 duration_in_ms=151.336
2017-12-18 14:36:39,033 [salt.state       ][INFO    ][19159] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 14:36:39.033281
2017-12-18 14:36:39,034 [salt.state       ][INFO    ][19159] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:36:39,034 [salt.state       ][INFO    ][19159] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-18 14:36:39,035 [salt.state       ][INFO    ][19159] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 14:36:39.034620 duration_in_ms=1.339
2017-12-18 14:36:39,038 [salt.state       ][INFO    ][19159] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 14:36:39.037749
2017-12-18 14:36:39,038 [salt.state       ][INFO    ][19159] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-18 14:36:39,039 [salt.state       ][INFO    ][19159] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-18 14:36:39,039 [salt.state       ][INFO    ][19159] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 14:36:39.039111 duration_in_ms=1.362
2017-12-18 14:36:39,040 [salt.state       ][INFO    ][19159] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 14:36:39.039468
2017-12-18 14:36:39,040 [salt.state       ][INFO    ][19159] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-18 14:36:39,043 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-12-18 14:36:39,058 [salt.state       ][INFO    ][19159] {'pid': 19236, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-18 14:36:39,059 [salt.state       ][INFO    ][19159] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 14:36:39.058394 duration_in_ms=18.926
2017-12-18 14:36:39,060 [salt.state       ][INFO    ][19159] Running state [mine.update] at time 14:36:39.059936
2017-12-18 14:36:39,061 [salt.state       ][INFO    ][19159] Executing state module.wait for mine.update
2017-12-18 14:36:39,061 [salt.state       ][INFO    ][19159] No changes made for mine.update
2017-12-18 14:36:39,061 [salt.state       ][INFO    ][19159] Completed state [mine.update] at time 14:36:39.061364 duration_in_ms=1.428
2017-12-18 14:36:39,062 [salt.state       ][INFO    ][19159] Running state [mine.update] at time 14:36:39.061713
2017-12-18 14:36:39,062 [salt.state       ][INFO    ][19159] Executing state module.mod_watch for mine.update
2017-12-18 14:36:39,594 [salt.state       ][INFO    ][19159] {'ret': True}
2017-12-18 14:36:39,595 [salt.state       ][INFO    ][19159] Completed state [mine.update] at time 14:36:39.594461 duration_in_ms=532.747
2017-12-18 14:36:39,595 [salt.state       ][INFO    ][19159] Running state [ca-certificates] at time 14:36:39.594976
2017-12-18 14:36:39,595 [salt.state       ][INFO    ][19159] Executing state pkg.installed for ca-certificates
2017-12-18 14:36:39,604 [salt.state       ][INFO    ][19159] Package ca-certificates is already installed
2017-12-18 14:36:39,604 [salt.state       ][INFO    ][19159] Completed state [ca-certificates] at time 14:36:39.604343 duration_in_ms=9.367
2017-12-18 14:36:39,606 [salt.state       ][INFO    ][19159] Running state [update-ca-certificates] at time 14:36:39.605500
2017-12-18 14:36:39,606 [salt.state       ][INFO    ][19159] Executing state cmd.wait for update-ca-certificates
2017-12-18 14:36:39,606 [salt.state       ][INFO    ][19159] No changes made for update-ca-certificates
2017-12-18 14:36:39,607 [salt.state       ][INFO    ][19159] Completed state [update-ca-certificates] at time 14:36:39.606729 duration_in_ms=1.229
2017-12-18 14:36:39,607 [salt.state       ][INFO    ][19159] Running state [libvirt-dev] at time 14:36:39.607108
2017-12-18 14:36:39,608 [salt.state       ][INFO    ][19159] Executing state pkg.installed for libvirt-dev
2017-12-18 14:36:39,615 [salt.state       ][INFO    ][19159] Package libvirt-dev is already installed
2017-12-18 14:36:39,615 [salt.state       ][INFO    ][19159] Completed state [libvirt-dev] at time 14:36:39.614874 duration_in_ms=7.766
2017-12-18 14:36:39,615 [salt.state       ][INFO    ][19159] Running state [pkg-config] at time 14:36:39.615255
2017-12-18 14:36:39,616 [salt.state       ][INFO    ][19159] Executing state pkg.installed for pkg-config
2017-12-18 14:36:39,622 [salt.state       ][INFO    ][19159] Package pkg-config is already installed
2017-12-18 14:36:39,623 [salt.state       ][INFO    ][19159] Completed state [pkg-config] at time 14:36:39.622547 duration_in_ms=7.292
2017-12-18 14:36:39,623 [salt.state       ][INFO    ][19159] Running state [virtng.init] at time 14:36:39.622909
2017-12-18 14:36:39,623 [salt.state       ][INFO    ][19159] Executing state module.run for virtng.init
2017-12-18 14:36:39,713 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command ['git', '--version'] in directory '/root'
2017-12-18 14:36:39,827 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:36:39,863 [salt.state       ][INFO    ][19159] unless execution succeeded
2017-12-18 14:36:39,966 [salt.state       ][INFO    ][19159] Completed state [virtng.init] at time 14:36:39.966172 duration_in_ms=343.262
2017-12-18 14:36:39,967 [salt.state       ][INFO    ][19159] Running state [virt.set_autostart] at time 14:36:39.966853
2017-12-18 14:36:39,967 [salt.state       ][INFO    ][19159] Executing state module.run for virt.set_autostart
2017-12-18 14:36:39,973 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:36:40,009 [salt.state       ][INFO    ][19159] unless execution succeeded
2017-12-18 14:36:40,009 [salt.state       ][INFO    ][19159] Completed state [virt.set_autostart] at time 14:36:40.009407 duration_in_ms=42.554
2017-12-18 14:36:40,010 [salt.state       ][INFO    ][19159] Running state [virtng.init] at time 14:36:40.009912
2017-12-18 14:36:40,010 [salt.state       ][INFO    ][19159] Executing state module.run for virtng.init
2017-12-18 14:36:40,015 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:36:40,049 [salt.state       ][INFO    ][19159] unless execution succeeded
2017-12-18 14:36:40,049 [salt.state       ][INFO    ][19159] Completed state [virtng.init] at time 14:36:40.049084 duration_in_ms=39.171
2017-12-18 14:36:40,050 [salt.state       ][INFO    ][19159] Running state [virt.set_autostart] at time 14:36:40.049707
2017-12-18 14:36:40,050 [salt.state       ][INFO    ][19159] Executing state module.run for virt.set_autostart
2017-12-18 14:36:40,056 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:36:40,090 [salt.state       ][INFO    ][19159] unless execution succeeded
2017-12-18 14:36:40,146 [salt.state       ][INFO    ][19159] Completed state [virt.set_autostart] at time 14:36:40.146052 duration_in_ms=96.344
2017-12-18 14:36:40,147 [salt.state       ][INFO    ][19159] Running state [virtng.init] at time 14:36:40.146679
2017-12-18 14:36:40,147 [salt.state       ][INFO    ][19159] Executing state module.run for virtng.init
2017-12-18 14:36:40,153 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:36:40,185 [salt.state       ][INFO    ][19159] unless execution succeeded
2017-12-18 14:36:40,243 [salt.state       ][INFO    ][19159] Completed state [virtng.init] at time 14:36:40.242827 duration_in_ms=96.147
2017-12-18 14:36:40,244 [salt.state       ][INFO    ][19159] Running state [virt.set_autostart] at time 14:36:40.243539
2017-12-18 14:36:40,244 [salt.state       ][INFO    ][19159] Executing state module.run for virt.set_autostart
2017-12-18 14:36:40,249 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:36:40,285 [salt.state       ][INFO    ][19159] unless execution succeeded
2017-12-18 14:36:40,286 [salt.state       ][INFO    ][19159] Completed state [virt.set_autostart] at time 14:36:40.285964 duration_in_ms=42.424
2017-12-18 14:36:40,287 [salt.state       ][INFO    ][19159] Running state [virtng.init] at time 14:36:40.286503
2017-12-18 14:36:40,287 [salt.state       ][INFO    ][19159] Executing state module.run for virtng.init
2017-12-18 14:36:40,294 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:36:40,329 [salt.state       ][INFO    ][19159] unless execution succeeded
2017-12-18 14:36:40,330 [salt.state       ][INFO    ][19159] Completed state [virtng.init] at time 14:36:40.329627 duration_in_ms=43.123
2017-12-18 14:36:40,330 [salt.state       ][INFO    ][19159] Running state [virt.set_autostart] at time 14:36:40.330136
2017-12-18 14:36:40,331 [salt.state       ][INFO    ][19159] Executing state module.run for virt.set_autostart
2017-12-18 14:36:40,335 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:36:40,366 [salt.state       ][INFO    ][19159] unless execution succeeded
2017-12-18 14:36:40,366 [salt.state       ][INFO    ][19159] Completed state [virt.set_autostart] at time 14:36:40.366026 duration_in_ms=35.89
2017-12-18 14:36:40,367 [salt.state       ][INFO    ][19159] Running state [virtng.init] at time 14:36:40.366548
2017-12-18 14:36:40,367 [salt.state       ][INFO    ][19159] Executing state module.run for virtng.init
2017-12-18 14:36:40,372 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:36:40,399 [salt.state       ][INFO    ][19159] unless execution succeeded
2017-12-18 14:36:40,400 [salt.state       ][INFO    ][19159] Completed state [virtng.init] at time 14:36:40.400241 duration_in_ms=33.692
2017-12-18 14:36:40,401 [salt.state       ][INFO    ][19159] Running state [virt.set_autostart] at time 14:36:40.400940
2017-12-18 14:36:40,401 [salt.state       ][INFO    ][19159] Executing state module.run for virt.set_autostart
2017-12-18 14:36:40,407 [salt.loaded.int.module.cmdmod][INFO    ][19159] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-pike-ovs-dpdk-ha.local$"' in directory '/root'
2017-12-18 14:36:40,437 [salt.state       ][INFO    ][19159] unless execution succeeded
2017-12-18 14:36:40,437 [salt.state       ][INFO    ][19159] Completed state [virt.set_autostart] at time 14:36:40.437108 duration_in_ms=36.168
2017-12-18 14:36:40,441 [salt.minion      ][INFO    ][19159] Returning information for job: 20171218143630416963
2017-12-18 14:36:41,422 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command pillar.get with jid 20171218143641422438
2017-12-18 14:36:41,437 [salt.minion      ][INFO    ][19289] Starting a new job with PID 19289
2017-12-18 14:36:41,549 [salt.minion      ][INFO    ][19289] Returning information for job: 20171218143641422438
2017-12-18 14:38:06,196 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171218143806191914
2017-12-18 14:38:06,212 [salt.minion      ][INFO    ][19302] Starting a new job with PID 19302
2017-12-18 14:38:09,672 [salt.state       ][INFO    ][19302] Loading fresh modules for state activity
2017-12-18 14:38:09,712 [salt.state       ][ERROR   ][19302] No contents found in top file
2017-12-18 14:38:09,713 [salt.utils.extmods][INFO    ][19302] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-18 14:38:09,717 [salt.utils.extmods][INFO    ][19302] Syncing beacons for environment 'base'
2017-12-18 14:38:09,717 [salt.utils.extmods][INFO    ][19302] Loading cache from salt://_beacons, for base)
2017-12-18 14:38:09,718 [salt.fileclient  ][INFO    ][19302] Caching directory '_beacons/' for environment 'base'
2017-12-18 14:38:09,755 [salt.utils.extmods][INFO    ][19302] Syncing modules for environment 'base'
2017-12-18 14:38:09,755 [salt.utils.extmods][INFO    ][19302] Loading cache from salt://_modules, for base)
2017-12-18 14:38:09,755 [salt.fileclient  ][INFO    ][19302] Caching directory '_modules/' for environment 'base'
2017-12-18 14:38:09,802 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-18 14:38:09,815 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-18 14:38:09,849 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-18 14:38:09,989 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-18 14:38:10,005 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-18 14:38:10,016 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-18 14:38:10,029 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-18 14:38:10,051 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-18 14:38:10,115 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-18 14:38:10,158 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-18 14:38:10,180 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-18 14:38:10,196 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-18 14:38:10,238 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-18 14:38:10,312 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-18 14:38:10,365 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-18 14:38:10,383 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-18 14:38:10,400 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-18 14:38:10,452 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-18 14:38:10,462 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/modelschema.py'
2017-12-18 14:38:10,478 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-18 14:38:10,510 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-18 14:38:10,523 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-18 14:38:10,533 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-18 14:38:10,545 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-18 14:38:10,557 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-18 14:38:10,579 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-18 14:38:10,596 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-18 14:38:10,606 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-18 14:38:10,616 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-18 14:38:10,675 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-18 14:38:10,694 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-18 14:38:10,703 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-18 14:38:10,713 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-18 14:38:10,725 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-18 14:38:10,738 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-18 14:38:10,745 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-18 14:38:10,745 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-18 14:38:10,746 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-18 14:38:10,747 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-18 14:38:10,747 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-18 14:38:10,755 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-18 14:38:10,755 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-18 14:38:10,756 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-18 14:38:10,757 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-18 14:38:10,758 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-18 14:38:10,758 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-18 14:38:10,759 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-18 14:38:10,760 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-18 14:38:10,760 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-18 14:38:10,761 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-18 14:38:10,761 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-18 14:38:10,762 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-18 14:38:10,763 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-18 14:38:10,763 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-18 14:38:10,764 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/modelschema.py' to '/var/cache/salt/minion/extmods/modules/modelschema.py'
2017-12-18 14:38:10,765 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-18 14:38:10,765 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-18 14:38:10,766 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-18 14:38:10,767 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-18 14:38:10,767 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-18 14:38:10,771 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-18 14:38:10,772 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-18 14:38:10,772 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-18 14:38:10,773 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-18 14:38:10,776 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-18 14:38:10,780 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-18 14:38:10,780 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-18 14:38:10,781 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-18 14:38:10,781 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-18 14:38:10,781 [salt.utils.extmods][INFO    ][19302] 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-12-18 14:38:10,782 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-18 14:38:10,783 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-18 14:38:10,794 [salt.utils.extmods][INFO    ][19302] Syncing states for environment 'base'
2017-12-18 14:38:10,794 [salt.utils.extmods][INFO    ][19302] Loading cache from salt://_states, for base)
2017-12-18 14:38:10,795 [salt.fileclient  ][INFO    ][19302] Caching directory '_states/' for environment 'base'
2017-12-18 14:38:10,833 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-18 14:38:10,848 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-18 14:38:10,859 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-18 14:38:10,899 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-18 14:38:10,912 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-18 14:38:10,965 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-18 14:38:11,009 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-18 14:38:11,022 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-18 14:38:11,039 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-18 14:38:11,056 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-18 14:38:11,067 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-18 14:38:11,078 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-18 14:38:11,087 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-18 14:38:11,096 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-18 14:38:11,124 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-18 14:38:11,135 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-18 14:38:11,142 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-18 14:38:11,150 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-18 14:38:11,164 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-18 14:38:11,211 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-18 14:38:11,305 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-18 14:38:11,368 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-18 14:38:11,427 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-18 14:38:11,479 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-18 14:38:11,512 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-18 14:38:11,531 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-18 14:38:11,590 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-18 14:38:11,605 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-18 14:38:11,622 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-18 14:38:11,635 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-18 14:38:11,677 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-18 14:38:11,731 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-18 14:38:11,737 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-18 14:38:11,738 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-18 14:38:11,738 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-18 14:38:11,739 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-18 14:38:11,739 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-18 14:38:11,740 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-18 14:38:11,741 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-18 14:38:11,741 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-18 14:38:11,742 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-18 14:38:11,742 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-18 14:38:11,743 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-18 14:38:11,743 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-18 14:38:11,743 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-18 14:38:11,744 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-18 14:38:11,744 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-18 14:38:11,745 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-18 14:38:11,745 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-18 14:38:11,746 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-18 14:38:11,746 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-18 14:38:11,747 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-18 14:38:11,747 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-18 14:38:11,748 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-18 14:38:11,748 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-18 14:38:11,749 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-18 14:38:11,749 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-18 14:38:11,750 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-18 14:38:11,750 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-18 14:38:11,751 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-18 14:38:11,751 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-18 14:38:11,752 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-18 14:38:11,752 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-18 14:38:11,753 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-18 14:38:11,753 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-18 14:38:11,756 [salt.utils.extmods][INFO    ][19302] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-18 14:38:11,761 [salt.utils.extmods][INFO    ][19302] Syncing sdb for environment 'base'
2017-12-18 14:38:11,761 [salt.utils.extmods][INFO    ][19302] Loading cache from salt://_sdb, for base)
2017-12-18 14:38:11,761 [salt.fileclient  ][INFO    ][19302] Caching directory '_sdb/' for environment 'base'
2017-12-18 14:38:11,795 [salt.utils.extmods][INFO    ][19302] Syncing grains for environment 'base'
2017-12-18 14:38:11,795 [salt.utils.extmods][INFO    ][19302] Loading cache from salt://_grains, for base)
2017-12-18 14:38:11,795 [salt.fileclient  ][INFO    ][19302] Caching directory '_grains/' for environment 'base'
2017-12-18 14:38:11,854 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-18 14:38:11,865 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-18 14:38:11,883 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-18 14:38:11,893 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-18 14:38:11,906 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-18 14:38:11,919 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-18 14:38:11,937 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-18 14:38:11,950 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-18 14:38:11,976 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-18 14:38:11,991 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-18 14:38:12,010 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-18 14:38:12,024 [salt.fileclient  ][INFO    ][19302] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-18 14:38:12,031 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-18 14:38:12,031 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-18 14:38:12,032 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-18 14:38:12,033 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-18 14:38:12,034 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-18 14:38:12,034 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-18 14:38:12,035 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-18 14:38:12,036 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-18 14:38:12,037 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-18 14:38:12,037 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-18 14:38:12,038 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-18 14:38:12,039 [salt.utils.extmods][INFO    ][19302] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-18 14:38:12,041 [salt.utils.extmods][INFO    ][19302] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-18 14:38:12,045 [salt.utils.extmods][INFO    ][19302] Syncing renderers for environment 'base'
2017-12-18 14:38:12,045 [salt.utils.extmods][INFO    ][19302] Loading cache from salt://_renderers, for base)
2017-12-18 14:38:12,045 [salt.fileclient  ][INFO    ][19302] Caching directory '_renderers/' for environment 'base'
2017-12-18 14:38:12,076 [salt.utils.extmods][INFO    ][19302] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-18 14:38:12,080 [salt.utils.extmods][INFO    ][19302] Syncing returners for environment 'base'
2017-12-18 14:38:12,080 [salt.utils.extmods][INFO    ][19302] Loading cache from salt://_returners, for base)
2017-12-18 14:38:12,080 [salt.fileclient  ][INFO    ][19302] Caching directory '_returners/' for environment 'base'
2017-12-18 14:38:12,305 [salt.utils.extmods][INFO    ][19302] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-18 14:38:12,310 [salt.utils.extmods][INFO    ][19302] Syncing output for environment 'base'
2017-12-18 14:38:12,311 [salt.utils.extmods][INFO    ][19302] Loading cache from salt://_output, for base)
2017-12-18 14:38:12,311 [salt.fileclient  ][INFO    ][19302] Caching directory '_output/' for environment 'base'
2017-12-18 14:38:12,344 [salt.utils.extmods][INFO    ][19302] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-18 14:38:12,349 [salt.utils.extmods][INFO    ][19302] Syncing utils for environment 'base'
2017-12-18 14:38:12,349 [salt.utils.extmods][INFO    ][19302] Loading cache from salt://_utils, for base)
2017-12-18 14:38:12,349 [salt.fileclient  ][INFO    ][19302] Caching directory '_utils/' for environment 'base'
2017-12-18 14:38:12,381 [salt.utils.extmods][INFO    ][19302] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-18 14:38:12,384 [salt.utils.extmods][INFO    ][19302] Syncing log_handlers for environment 'base'
2017-12-18 14:38:12,384 [salt.utils.extmods][INFO    ][19302] Loading cache from salt://_log_handlers, for base)
2017-12-18 14:38:12,385 [salt.fileclient  ][INFO    ][19302] Caching directory '_log_handlers/' for environment 'base'
2017-12-18 14:38:12,419 [salt.utils.extmods][INFO    ][19302] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-18 14:38:12,422 [salt.utils.extmods][INFO    ][19302] Syncing proxy for environment 'base'
2017-12-18 14:38:12,422 [salt.utils.extmods][INFO    ][19302] Loading cache from salt://_proxy, for base)
2017-12-18 14:38:12,422 [salt.fileclient  ][INFO    ][19302] Caching directory '_proxy/' for environment 'base'
2017-12-18 14:38:12,458 [salt.utils.extmods][INFO    ][19302] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-18 14:38:12,463 [salt.utils.extmods][INFO    ][19302] Syncing engines for environment 'base'
2017-12-18 14:38:12,464 [salt.utils.extmods][INFO    ][19302] Loading cache from salt://_engines, for base)
2017-12-18 14:38:12,464 [salt.fileclient  ][INFO    ][19302] Caching directory '_engines/' for environment 'base'
2017-12-18 14:38:12,499 [salt.minion      ][INFO    ][19302] Returning information for job: 20171218143806191914
2017-12-18 15:06:17,946 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command test.ping with jid 20171218150617946192
2017-12-18 15:06:17,969 [salt.minion      ][INFO    ][19627] Starting a new job with PID 19627
2017-12-18 15:06:18,037 [salt.minion      ][INFO    ][19627] Returning information for job: 20171218150617946192
2017-12-18 15:06:30,786 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command state.sls with jid 20171218150630785937
2017-12-18 15:06:30,805 [salt.minion      ][INFO    ][19635] Starting a new job with PID 19635
2017-12-18 15:06:31,355 [salt.state       ][INFO    ][19635] Loading fresh modules for state activity
2017-12-18 15:06:31,399 [salt.fileclient  ][INFO    ][19635] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-18 15:06:31,429 [salt.fileclient  ][INFO    ][19635] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-18 15:06:31,469 [salt.fileclient  ][INFO    ][19635] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-18 15:06:31,926 [salt.state       ][INFO    ][19635] Running state [lsof] at time 15:06:31.925809
2017-12-18 15:06:31,926 [salt.state       ][INFO    ][19635] Executing state pkg.installed for lsof
2017-12-18 15:06:31,927 [salt.loaded.int.module.cmdmod][INFO    ][19635] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 15:06:32,286 [salt.state       ][INFO    ][19635] Package lsof is already installed
2017-12-18 15:06:32,287 [salt.state       ][INFO    ][19635] Completed state [lsof] at time 15:06:32.286570 duration_in_ms=360.76
2017-12-18 15:06:32,287 [salt.state       ][INFO    ][19635] Running state [keepalived] at time 15:06:32.286776
2017-12-18 15:06:32,287 [salt.state       ][INFO    ][19635] Executing state pkg.installed for keepalived
2017-12-18 15:06:32,307 [salt.loaded.int.module.cmdmod][INFO    ][19635] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-18 15:06:36,134 [salt.loaded.int.module.cmdmod][INFO    ][19635] 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-12-18 15:06:40,832 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218150640831170
2017-12-18 15:06:40,848 [salt.minion      ][INFO    ][20624] Starting a new job with PID 20624
2017-12-18 15:06:40,878 [salt.minion      ][INFO    ][20624] Returning information for job: 20171218150640831170
2017-12-18 15:06:45,382 [salt.loaded.int.module.cmdmod][INFO    ][19635] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 15:06:45,436 [salt.state       ][INFO    ][19635] 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-12-18 15:06:45,467 [salt.state       ][INFO    ][19635] Loading fresh modules for state activity
2017-12-18 15:06:45,493 [salt.state       ][INFO    ][19635] Completed state [keepalived] at time 15:06:45.493308 duration_in_ms=13206.53
2017-12-18 15:06:45,498 [salt.state       ][INFO    ][19635] Running state [/etc/keepalived/keepalived.conf] at time 15:06:45.497520
2017-12-18 15:06:45,498 [salt.state       ][INFO    ][19635] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-18 15:06:45,530 [salt.fileclient  ][INFO    ][19635] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-18 15:06:45,578 [salt.fileclient  ][INFO    ][19635] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-18 15:06:45,588 [salt.state       ][INFO    ][19635] File changed:
New file
2017-12-18 15:06:45,588 [salt.state       ][INFO    ][19635] Completed state [/etc/keepalived/keepalived.conf] at time 15:06:45.588060 duration_in_ms=90.54
2017-12-18 15:06:45,672 [salt.state       ][INFO    ][19635] Running state [keepalived] at time 15:06:45.671469
2017-12-18 15:06:45,672 [salt.state       ][INFO    ][19635] Executing state service.running for keepalived
2017-12-18 15:06:45,673 [salt.loaded.int.module.cmdmod][INFO    ][19635] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-18 15:06:45,690 [salt.loaded.int.module.cmdmod][INFO    ][19635] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-18 15:06:45,703 [salt.loaded.int.module.cmdmod][INFO    ][19635] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-18 15:06:45,714 [salt.loaded.int.module.cmdmod][INFO    ][19635] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-18 15:06:45,727 [salt.loaded.int.module.cmdmod][INFO    ][19635] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-12-18 15:06:45,811 [salt.loaded.int.module.cmdmod][INFO    ][19635] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-18 15:06:45,823 [salt.loaded.int.module.cmdmod][INFO    ][19635] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-18 15:06:45,834 [salt.loaded.int.module.cmdmod][INFO    ][19635] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-18 15:06:45,845 [salt.state       ][INFO    ][19635] {'keepalived': True}
2017-12-18 15:06:45,845 [salt.state       ][INFO    ][19635] Completed state [keepalived] at time 15:06:45.845419 duration_in_ms=173.948
2017-12-18 15:06:45,847 [salt.minion      ][INFO    ][19635] Returning information for job: 20171218150630785937
2017-12-18 15:10:19,223 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command pillar.get with jid 20171218151019226206
2017-12-18 15:10:19,244 [salt.minion      ][INFO    ][21083] Starting a new job with PID 21083
2017-12-18 15:10:19,251 [salt.minion      ][INFO    ][21083] Returning information for job: 20171218151019226206
2017-12-18 15:15:31,121 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command state.sls with jid 20171218151531117593
2017-12-18 15:15:31,139 [salt.minion      ][INFO    ][21162] Starting a new job with PID 21162
2017-12-18 15:15:32,778 [salt.state       ][INFO    ][21162] Loading fresh modules for state activity
2017-12-18 15:15:32,819 [salt.fileclient  ][INFO    ][21162] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-18 15:15:32,853 [salt.fileclient  ][INFO    ][21162] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-18 15:15:33,186 [salt.state       ][INFO    ][21162] Running state [attr] at time 15:15:33.186074
2017-12-18 15:15:33,186 [salt.state       ][INFO    ][21162] Executing state pkg.installed for attr
2017-12-18 15:15:33,187 [salt.loaded.int.module.cmdmod][INFO    ][21162] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 15:15:33,512 [salt.loaded.int.module.cmdmod][INFO    ][21162] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-18 15:15:35,659 [salt.loaded.int.module.cmdmod][INFO    ][21162] 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-12-18 15:15:38,757 [salt.loaded.int.module.cmdmod][INFO    ][21162] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 15:15:38,813 [salt.state       ][INFO    ][21162] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-12-18 15:15:38,832 [salt.state       ][INFO    ][21162] Loading fresh modules for state activity
2017-12-18 15:15:38,858 [salt.state       ][INFO    ][21162] Completed state [attr] at time 15:15:38.858211 duration_in_ms=5672.137
2017-12-18 15:15:38,867 [salt.state       ][INFO    ][21162] Running state [glusterfs-server] at time 15:15:38.866923
2017-12-18 15:15:38,867 [salt.state       ][INFO    ][21162] Executing state pkg.installed for glusterfs-server
2017-12-18 15:15:39,245 [salt.loaded.int.module.cmdmod][INFO    ][21162] 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-12-18 15:15:41,216 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218151541211631
2017-12-18 15:15:41,234 [salt.minion      ][INFO    ][21962] Starting a new job with PID 21962
2017-12-18 15:15:41,256 [salt.minion      ][INFO    ][21962] Returning information for job: 20171218151541211631
2017-12-18 15:15:51,435 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218151551431008
2017-12-18 15:15:51,452 [salt.minion      ][INFO    ][21985] Starting a new job with PID 21985
2017-12-18 15:15:51,473 [salt.minion      ][INFO    ][21985] Returning information for job: 20171218151551431008
2017-12-18 15:16:01,657 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218151601653530
2017-12-18 15:16:01,672 [salt.minion      ][INFO    ][23089] Starting a new job with PID 23089
2017-12-18 15:16:01,691 [salt.minion      ][INFO    ][23089] Returning information for job: 20171218151601653530
2017-12-18 15:16:08,698 [salt.loaded.int.module.cmdmod][INFO    ][21162] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 15:16:08,755 [salt.state       ][INFO    ][21162] Made the following changes:
'python-jwt' changed from 'absent' to '1.3.0-1ubuntu0.1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.2'
'glusterfs-client' changed from 'absent' to '3.13.0-ubuntu1~xenial1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'glusterfs-common' changed from 'absent' to '3.13.0-ubuntu1~xenial1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'portmap' changed from 'absent' to '1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'libtirpc1' changed from 'absent' to '0.2.5-1'
'nfs-client' changed from 'absent' to '1'
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'glusterfs-server' changed from 'absent' to '3.13.0-ubuntu1~xenial1'
'python-prettytable' changed from 'absent' to '0.7.2-3'

2017-12-18 15:16:08,771 [salt.state       ][INFO    ][21162] Loading fresh modules for state activity
2017-12-18 15:16:08,796 [salt.state       ][INFO    ][21162] Completed state [glusterfs-server] at time 15:16:08.796053 duration_in_ms=29929.129
2017-12-18 15:16:08,804 [salt.state       ][INFO    ][21162] Running state [bc] at time 15:16:08.804272
2017-12-18 15:16:08,805 [salt.state       ][INFO    ][21162] Executing state pkg.installed for bc
2017-12-18 15:16:09,060 [salt.loaded.int.module.cmdmod][INFO    ][21162] 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-12-18 15:16:11,725 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command saltutil.find_job with jid 20171218151611720844
2017-12-18 15:16:11,744 [salt.minion      ][INFO    ][23992] Starting a new job with PID 23992
2017-12-18 15:16:11,771 [salt.minion      ][INFO    ][23992] Returning information for job: 20171218151611720844
2017-12-18 15:16:12,633 [salt.loaded.int.module.cmdmod][INFO    ][21162] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 15:16:12,690 [salt.state       ][INFO    ][21162] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-12-18 15:16:12,706 [salt.state       ][INFO    ][21162] Loading fresh modules for state activity
2017-12-18 15:16:12,731 [salt.state       ][INFO    ][21162] Completed state [bc] at time 15:16:12.730473 duration_in_ms=3926.2
2017-12-18 15:16:12,815 [salt.state       ][INFO    ][21162] Running state [glusterd] at time 15:16:12.815336
2017-12-18 15:16:12,816 [salt.state       ][INFO    ][21162] Executing state service.running for glusterd
2017-12-18 15:16:12,817 [salt.loaded.int.module.cmdmod][INFO    ][21162] Executing command ['systemctl', 'status', 'glusterd.service', '-n', '0'] in directory '/root'
2017-12-18 15:16:12,834 [salt.loaded.int.module.cmdmod][INFO    ][21162] Executing command ['systemctl', 'is-active', 'glusterd.service'] in directory '/root'
2017-12-18 15:16:12,847 [salt.loaded.int.module.cmdmod][INFO    ][21162] Executing command ['systemctl', 'is-enabled', 'glusterd.service'] in directory '/root'
2017-12-18 15:16:12,859 [salt.state       ][INFO    ][21162] The service glusterd is already running
2017-12-18 15:16:12,859 [salt.state       ][INFO    ][21162] Completed state [glusterd] at time 15:16:12.858942 duration_in_ms=43.605
2017-12-18 15:16:12,861 [salt.state       ][INFO    ][21162] Running state [/etc/systemd/system/glusterd.service.d/override.conf] at time 15:16:12.860766
2017-12-18 15:16:12,861 [salt.state       ][INFO    ][21162] Executing state file.managed for /etc/systemd/system/glusterd.service.d/override.conf
2017-12-18 15:16:12,889 [salt.state       ][INFO    ][21162] File changed:
New file
2017-12-18 15:16:12,889 [salt.state       ][INFO    ][21162] Completed state [/etc/systemd/system/glusterd.service.d/override.conf] at time 15:16:12.889423 duration_in_ms=28.656
2017-12-18 15:16:12,890 [salt.state       ][INFO    ][21162] Running state [/srv/glusterfs/glance] at time 15:16:12.889819
2017-12-18 15:16:12,890 [salt.state       ][INFO    ][21162] Executing state file.directory for /srv/glusterfs/glance
2017-12-18 15:16:12,903 [salt.state       ][INFO    ][21162] {'/srv/glusterfs/glance': 'New Dir'}
2017-12-18 15:16:12,903 [salt.state       ][INFO    ][21162] Completed state [/srv/glusterfs/glance] at time 15:16:12.902927 duration_in_ms=13.108
2017-12-18 15:16:12,903 [salt.state       ][INFO    ][21162] Running state [/srv/glusterfs/keystone-keys] at time 15:16:12.903272
2017-12-18 15:16:12,904 [salt.state       ][INFO    ][21162] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-18 15:16:12,905 [salt.state       ][INFO    ][21162] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-12-18 15:16:12,905 [salt.state       ][INFO    ][21162] Completed state [/srv/glusterfs/keystone-keys] at time 15:16:12.904784 duration_in_ms=1.511
2017-12-18 15:16:12,905 [salt.state       ][INFO    ][21162] Running state [/srv/glusterfs/nova_instances] at time 15:16:12.905121
2017-12-18 15:16:12,905 [salt.state       ][INFO    ][21162] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-18 15:16:12,906 [salt.state       ][INFO    ][21162] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-12-18 15:16:12,907 [salt.state       ][INFO    ][21162] Completed state [/srv/glusterfs/nova_instances] at time 15:16:12.906593 duration_in_ms=1.472
2017-12-18 15:16:12,907 [salt.state       ][INFO    ][21162] Running state [/srv/glusterfs/keystone-credential-keys] at time 15:16:12.906930
2017-12-18 15:16:12,907 [salt.state       ][INFO    ][21162] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-18 15:16:12,908 [salt.state       ][INFO    ][21162] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-12-18 15:16:12,909 [salt.state       ][INFO    ][21162] Completed state [/srv/glusterfs/keystone-credential-keys] at time 15:16:12.908488 duration_in_ms=1.558
2017-12-18 15:16:12,910 [salt.minion      ][INFO    ][21162] Returning information for job: 20171218151531117593
2017-12-18 15:16:14,110 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command test.ping with jid 20171218151614107499
2017-12-18 15:16:14,127 [salt.minion      ][INFO    ][24067] Starting a new job with PID 24067
2017-12-18 15:16:14,192 [salt.minion      ][INFO    ][24067] Returning information for job: 20171218151614107499
2017-12-18 15:16:58,769 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command state.sls with jid 20171218151658766935
2017-12-18 15:16:58,788 [salt.minion      ][INFO    ][24703] Starting a new job with PID 24703
2017-12-18 15:17:00,652 [salt.state       ][INFO    ][24703] Loading fresh modules for state activity
2017-12-18 15:17:00,690 [salt.fileclient  ][INFO    ][24703] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-18 15:17:00,749 [salt.fileclient  ][INFO    ][24703] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-18 15:17:00,854 [salt.fileclient  ][INFO    ][24703] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-18 15:17:00,876 [salt.fileclient  ][INFO    ][24703] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-18 15:17:01,189 [salt.state       ][INFO    ][24703] Running state [attr] at time 15:17:01.189298
2017-12-18 15:17:01,190 [salt.state       ][INFO    ][24703] Executing state pkg.installed for attr
2017-12-18 15:17:01,190 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 15:17:01,472 [salt.state       ][INFO    ][24703] Package attr is already installed
2017-12-18 15:17:01,472 [salt.state       ][INFO    ][24703] Completed state [attr] at time 15:17:01.472330 duration_in_ms=283.031
2017-12-18 15:17:01,473 [salt.state       ][INFO    ][24703] Running state [glusterfs-server] at time 15:17:01.472549
2017-12-18 15:17:01,473 [salt.state       ][INFO    ][24703] Executing state pkg.installed for glusterfs-server
2017-12-18 15:17:01,475 [salt.state       ][INFO    ][24703] Package glusterfs-server is already installed
2017-12-18 15:17:01,476 [salt.state       ][INFO    ][24703] Completed state [glusterfs-server] at time 15:17:01.475584 duration_in_ms=3.035
2017-12-18 15:17:01,476 [salt.state       ][INFO    ][24703] Running state [bc] at time 15:17:01.475737
2017-12-18 15:17:01,476 [salt.state       ][INFO    ][24703] Executing state pkg.installed for bc
2017-12-18 15:17:01,479 [salt.state       ][INFO    ][24703] Package bc is already installed
2017-12-18 15:17:01,479 [salt.state       ][INFO    ][24703] Completed state [bc] at time 15:17:01.478666 duration_in_ms=2.929
2017-12-18 15:17:01,480 [salt.state       ][INFO    ][24703] Running state [glusterd] at time 15:17:01.479498
2017-12-18 15:17:01,480 [salt.state       ][INFO    ][24703] Executing state service.running for glusterd
2017-12-18 15:17:01,480 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command ['systemctl', 'status', 'glusterd.service', '-n', '0'] in directory '/root'
2017-12-18 15:17:01,496 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-18 15:17:01,610 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command ['systemctl', 'status', 'glusterd.service', '-n', '0'] in directory '/root'
2017-12-18 15:17:01,632 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command ['systemctl', 'is-active', 'glusterd.service'] in directory '/root'
2017-12-18 15:17:01,642 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command ['systemctl', 'is-enabled', 'glusterd.service'] in directory '/root'
2017-12-18 15:17:01,653 [salt.state       ][INFO    ][24703] The service glusterd is already running
2017-12-18 15:17:01,654 [salt.state       ][INFO    ][24703] Completed state [glusterd] at time 15:17:01.653486 duration_in_ms=173.987
2017-12-18 15:17:01,657 [salt.state       ][INFO    ][24703] Running state [/etc/systemd/system/glusterd.service.d/override.conf] at time 15:17:01.656746
2017-12-18 15:17:01,657 [salt.state       ][INFO    ][24703] Executing state file.managed for /etc/systemd/system/glusterd.service.d/override.conf
2017-12-18 15:17:01,670 [salt.state       ][INFO    ][24703] File /etc/systemd/system/glusterd.service.d/override.conf is in the correct state
2017-12-18 15:17:01,670 [salt.state       ][INFO    ][24703] Completed state [/etc/systemd/system/glusterd.service.d/override.conf] at time 15:17:01.670268 duration_in_ms=13.522
2017-12-18 15:17:01,671 [salt.state       ][INFO    ][24703] Running state [/srv/glusterfs/glance] at time 15:17:01.670632
2017-12-18 15:17:01,671 [salt.state       ][INFO    ][24703] Executing state file.directory for /srv/glusterfs/glance
2017-12-18 15:17:01,672 [salt.state       ][INFO    ][24703] Directory /srv/glusterfs/glance is in the correct state
2017-12-18 15:17:01,672 [salt.state       ][INFO    ][24703] Completed state [/srv/glusterfs/glance] at time 15:17:01.672069 duration_in_ms=1.437
2017-12-18 15:17:01,672 [salt.state       ][INFO    ][24703] Running state [/srv/glusterfs/keystone-keys] at time 15:17:01.672419
2017-12-18 15:17:01,673 [salt.state       ][INFO    ][24703] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-18 15:17:01,674 [salt.state       ][INFO    ][24703] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-18 15:17:01,674 [salt.state       ][INFO    ][24703] Completed state [/srv/glusterfs/keystone-keys] at time 15:17:01.673800 duration_in_ms=1.381
2017-12-18 15:17:01,674 [salt.state       ][INFO    ][24703] Running state [/srv/glusterfs/nova_instances] at time 15:17:01.674150
2017-12-18 15:17:01,675 [salt.state       ][INFO    ][24703] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-18 15:17:01,675 [salt.state       ][INFO    ][24703] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-18 15:17:01,676 [salt.state       ][INFO    ][24703] Completed state [/srv/glusterfs/nova_instances] at time 15:17:01.675561 duration_in_ms=1.41
2017-12-18 15:17:01,676 [salt.state       ][INFO    ][24703] Running state [/srv/glusterfs/keystone-credential-keys] at time 15:17:01.675907
2017-12-18 15:17:01,676 [salt.state       ][INFO    ][24703] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-18 15:17:01,677 [salt.state       ][INFO    ][24703] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-18 15:17:01,677 [salt.state       ][INFO    ][24703] Completed state [/srv/glusterfs/keystone-credential-keys] at time 15:17:01.677340 duration_in_ms=1.433
2017-12-18 15:17:01,862 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command ['git', '--version'] in directory '/root'
2017-12-18 15:17:01,956 [salt.state       ][INFO    ][24703] Running state [sleep 5] at time 15:17:01.956167
2017-12-18 15:17:01,957 [salt.state       ][INFO    ][24703] Executing state cmd.wait for sleep 5
2017-12-18 15:17:01,957 [salt.state       ][INFO    ][24703] No changes made for sleep 5
2017-12-18 15:17:01,957 [salt.state       ][INFO    ][24703] Completed state [sleep 5] at time 15:17:01.957223 duration_in_ms=1.057
2017-12-18 15:17:01,958 [salt.state       ][INFO    ][24703] Running state [10.167.4.141] at time 15:17:01.957818
2017-12-18 15:17:01,958 [salt.state       ][INFO    ][24703] Executing state glusterfs.peered for 10.167.4.141
2017-12-18 15:17:01,959 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:01,976 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:02,094 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:02,111 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:02,229 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:02,245 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:02,358 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:02,377 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:02,489 [salt.state       ][INFO    ][24703] Peering with localhost is not needed
2017-12-18 15:17:02,489 [salt.state       ][INFO    ][24703] Completed state [10.167.4.141] at time 15:17:02.489306 duration_in_ms=531.486
2017-12-18 15:17:02,495 [salt.state       ][INFO    ][24703] Running state [10.167.4.142] at time 15:17:02.495172
2017-12-18 15:17:02,496 [salt.state       ][INFO    ][24703] Executing state glusterfs.peered for 10.167.4.142
2017-12-18 15:17:02,497 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:02,514 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:02,625 [salt.state       ][INFO    ][24703] Host 10.167.4.142 already peered
2017-12-18 15:17:02,626 [salt.state       ][INFO    ][24703] Completed state [10.167.4.142] at time 15:17:02.625966 duration_in_ms=130.792
2017-12-18 15:17:02,632 [salt.state       ][INFO    ][24703] Running state [10.167.4.143] at time 15:17:02.631783
2017-12-18 15:17:02,632 [salt.state       ][INFO    ][24703] Executing state glusterfs.peered for 10.167.4.143
2017-12-18 15:17:02,633 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:02,651 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:02,768 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:02,785 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:02,908 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:02,927 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:03,048 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:03,065 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:03,175 [salt.state       ][INFO    ][24703] {'new': {'10.167.4.142': [], 'kvm03': ['10.167.4.143']}, 'old': {'10.167.4.142': [], 'kvm03': []}}
2017-12-18 15:17:03,175 [salt.state       ][INFO    ][24703] Completed state [10.167.4.143] at time 15:17:03.175339 duration_in_ms=543.555
2017-12-18 15:17:03,177 [salt.state       ][INFO    ][24703] Running state [glance] at time 15:17:03.177252
2017-12-18 15:17:03,178 [salt.state       ][INFO    ][24703] Executing state glusterfs.created for glance
2017-12-18 15:17:03,179 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:03,193 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:03,306 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:03,324 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:03,447 [salt.state       ][INFO    ][24703] Volume glance already exists and is started.
2017-12-18 15:17:03,447 [salt.state       ][INFO    ][24703] Completed state [glance] at time 15:17:03.447340 duration_in_ms=270.087
2017-12-18 15:17:03,456 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 15:17:03.455617
2017-12-18 15:17:03,456 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-18 15:17:03,457 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-18 15:17:03,565 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:03,566 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 15:17:03.565741 duration_in_ms=110.124
2017-12-18 15:17:03,567 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 15:17:03.566791
2017-12-18 15:17:03,567 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-18 15:17:03,568 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-18 15:17:03,667 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:03,667 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 15:17:03.667117 duration_in_ms=100.325
2017-12-18 15:17:03,668 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 15:17:03.668007
2017-12-18 15:17:03,668 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-18 15:17:03,669 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-18 15:17:03,785 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:03,786 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 15:17:03.785554 duration_in_ms=117.545
2017-12-18 15:17:03,787 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 15:17:03.786801
2017-12-18 15:17:03,787 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-18 15:17:03,789 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-18 15:17:03,906 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:03,906 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 15:17:03.906264 duration_in_ms=119.463
2017-12-18 15:17:03,908 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 15:17:03.907439
2017-12-18 15:17:03,908 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-18 15:17:03,909 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-18 15:17:04,018 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:04,018 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 15:17:04.018159 duration_in_ms=110.72
2017-12-18 15:17:04,020 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 15:17:04.019409
2017-12-18 15:17:04,020 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-18 15:17:04,021 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-18 15:17:04,138 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:04,139 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 15:17:04.138419 duration_in_ms=119.01
2017-12-18 15:17:04,141 [salt.state       ][INFO    ][24703] Running state [glance] at time 15:17:04.140534
2017-12-18 15:17:04,141 [salt.state       ][INFO    ][24703] Executing state glusterfs.started for glance
2017-12-18 15:17:04,142 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:04,159 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:04,274 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:04,292 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:04,409 [salt.state       ][INFO    ][24703] Volume glance is already started
2017-12-18 15:17:04,409 [salt.state       ][INFO    ][24703] Completed state [glance] at time 15:17:04.409183 duration_in_ms=268.648
2017-12-18 15:17:04,411 [salt.state       ][INFO    ][24703] Running state [keystone-keys] at time 15:17:04.411180
2017-12-18 15:17:04,412 [salt.state       ][INFO    ][24703] Executing state glusterfs.created for keystone-keys
2017-12-18 15:17:04,413 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:04,431 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:04,543 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:04,561 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:04,683 [salt.state       ][INFO    ][24703] Volume keystone-keys already exists and is started.
2017-12-18 15:17:04,683 [salt.state       ][INFO    ][24703] Completed state [keystone-keys] at time 15:17:04.683275 duration_in_ms=272.094
2017-12-18 15:17:04,692 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 15:17:04.692392
2017-12-18 15:17:04,693 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-18 15:17:04,694 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-18 15:17:04,782 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:04,783 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 15:17:04.782820 duration_in_ms=90.427
2017-12-18 15:17:04,784 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:17:04.784070
2017-12-18 15:17:04,785 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-18 15:17:04,786 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-18 15:17:04,890 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:04,891 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:17:04.890822 duration_in_ms=106.753
2017-12-18 15:17:04,892 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 15:17:04.892013
2017-12-18 15:17:04,893 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-18 15:17:04,893 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-18 15:17:04,982 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:04,983 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 15:17:04.982865 duration_in_ms=90.854
2017-12-18 15:17:04,984 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:17:04.983814
2017-12-18 15:17:04,984 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-18 15:17:04,985 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-18 15:17:05,100 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:05,100 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:17:05.100261 duration_in_ms=116.447
2017-12-18 15:17:05,101 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 15:17:05.101174
2017-12-18 15:17:05,102 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-18 15:17:05,102 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-18 15:17:05,217 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:05,218 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 15:17:05.217555 duration_in_ms=116.38
2017-12-18 15:17:05,219 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 15:17:05.218657
2017-12-18 15:17:05,219 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-18 15:17:05,220 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-18 15:17:05,335 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:05,335 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 15:17:05.335272 duration_in_ms=116.614
2017-12-18 15:17:05,338 [salt.state       ][INFO    ][24703] Running state [keystone-keys] at time 15:17:05.337931
2017-12-18 15:17:05,338 [salt.state       ][INFO    ][24703] Executing state glusterfs.started for keystone-keys
2017-12-18 15:17:05,339 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:05,354 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:05,471 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:05,488 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:05,610 [salt.state       ][INFO    ][24703] Volume keystone-keys is already started
2017-12-18 15:17:05,611 [salt.state       ][INFO    ][24703] Completed state [keystone-keys] at time 15:17:05.610694 duration_in_ms=272.762
2017-12-18 15:17:05,613 [salt.state       ][INFO    ][24703] Running state [nova_instances] at time 15:17:05.612673
2017-12-18 15:17:05,613 [salt.state       ][INFO    ][24703] Executing state glusterfs.created for nova_instances
2017-12-18 15:17:05,614 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:05,632 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:05,743 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:05,762 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:05,881 [salt.state       ][INFO    ][24703] Volume nova_instances already exists and is started.
2017-12-18 15:17:05,882 [salt.state       ][INFO    ][24703] Completed state [nova_instances] at time 15:17:05.881731 duration_in_ms=269.057
2017-12-18 15:17:05,890 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 15:17:05.890415
2017-12-18 15:17:05,891 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-18 15:17:05,892 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-18 15:17:06,005 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:06,006 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 15:17:06.005477 duration_in_ms=115.061
2017-12-18 15:17:06,007 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 15:17:06.006630
2017-12-18 15:17:06,007 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-18 15:17:06,009 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-18 15:17:06,117 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:06,117 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 15:17:06.117275 duration_in_ms=110.644
2017-12-18 15:17:06,119 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 15:17:06.118452
2017-12-18 15:17:06,119 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-18 15:17:06,120 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-18 15:17:06,237 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:06,237 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 15:17:06.237075 duration_in_ms=118.624
2017-12-18 15:17:06,238 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 15:17:06.237924
2017-12-18 15:17:06,238 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-18 15:17:06,239 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-18 15:17:06,345 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:06,346 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 15:17:06.345835 duration_in_ms=107.91
2017-12-18 15:17:06,347 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 15:17:06.346991
2017-12-18 15:17:06,348 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-18 15:17:06,349 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-18 15:17:06,462 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:06,462 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 15:17:06.462057 duration_in_ms=115.065
2017-12-18 15:17:06,464 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 15:17:06.463460
2017-12-18 15:17:06,464 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-18 15:17:06,465 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-18 15:17:06,560 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:06,560 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 15:17:06.560018 duration_in_ms=96.559
2017-12-18 15:17:06,563 [salt.state       ][INFO    ][24703] Running state [nova_instances] at time 15:17:06.562829
2017-12-18 15:17:06,563 [salt.state       ][INFO    ][24703] Executing state glusterfs.started for nova_instances
2017-12-18 15:17:06,564 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:06,580 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:06,689 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:06,702 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:06,815 [salt.state       ][INFO    ][24703] Volume nova_instances is already started
2017-12-18 15:17:06,815 [salt.state       ][INFO    ][24703] Completed state [nova_instances] at time 15:17:06.815051 duration_in_ms=252.222
2017-12-18 15:17:06,817 [salt.state       ][INFO    ][24703] Running state [keystone-credential-keys] at time 15:17:06.817048
2017-12-18 15:17:06,818 [salt.state       ][INFO    ][24703] Executing state glusterfs.created for keystone-credential-keys
2017-12-18 15:17:06,818 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:06,836 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:06,949 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:06,965 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:07,085 [salt.state       ][INFO    ][24703] Volume keystone-credential-keys already exists and is started.
2017-12-18 15:17:07,086 [salt.state       ][INFO    ][24703] Completed state [keystone-credential-keys] at time 15:17:07.085435 duration_in_ms=268.387
2017-12-18 15:17:07,093 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 15:17:07.093374
2017-12-18 15:17:07,094 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-18 15:17:07,095 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-18 15:17:07,207 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:07,208 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 15:17:07.207887 duration_in_ms=114.511
2017-12-18 15:17:07,209 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 15:17:07.209324
2017-12-18 15:17:07,210 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-18 15:17:07,211 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-18 15:17:07,326 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:07,326 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 15:17:07.326219 duration_in_ms=116.895
2017-12-18 15:17:07,327 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:17:07.327318
2017-12-18 15:17:07,328 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-18 15:17:07,329 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-18 15:17:07,441 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:07,441 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:17:07.441115 duration_in_ms=113.797
2017-12-18 15:17:07,442 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 15:17:07.442199
2017-12-18 15:17:07,443 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-18 15:17:07,444 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-18 15:17:07,557 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:07,558 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 15:17:07.557701 duration_in_ms=115.501
2017-12-18 15:17:07,559 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:17:07.558723
2017-12-18 15:17:07,559 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-18 15:17:07,560 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-18 15:17:07,673 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:07,673 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:17:07.673388 duration_in_ms=114.663
2017-12-18 15:17:07,675 [salt.state       ][INFO    ][24703] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 15:17:07.674484
2017-12-18 15:17:07,675 [salt.state       ][INFO    ][24703] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-18 15:17:07,676 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-18 15:17:07,787 [salt.state       ][INFO    ][24703] unless execution succeeded
2017-12-18 15:17:07,787 [salt.state       ][INFO    ][24703] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 15:17:07.787365 duration_in_ms=112.879
2017-12-18 15:17:07,790 [salt.state       ][INFO    ][24703] Running state [keystone-credential-keys] at time 15:17:07.790352
2017-12-18 15:17:07,791 [salt.state       ][INFO    ][24703] Executing state glusterfs.started for keystone-credential-keys
2017-12-18 15:17:07,792 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:07,808 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:07,920 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --version' in directory '/root'
2017-12-18 15:17:07,939 [salt.loaded.int.module.cmdmod][INFO    ][24703] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 15:17:08,069 [salt.state       ][INFO    ][24703] Volume keystone-credential-keys is already started
2017-12-18 15:17:08,070 [salt.state       ][INFO    ][24703] Completed state [keystone-credential-keys] at time 15:17:08.069931 duration_in_ms=279.577
2017-12-18 15:17:08,074 [salt.minion      ][INFO    ][24703] Returning information for job: 20171218151658766935
2017-12-18 15:17:17,114 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command test.ping with jid 20171218151717108993
2017-12-18 15:17:17,134 [salt.minion      ][INFO    ][25345] Starting a new job with PID 25345
2017-12-18 15:17:17,194 [salt.minion      ][INFO    ][25345] Returning information for job: 20171218151717108993
2017-12-18 15:17:17,721 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command cmd.run with jid 20171218151717718074
2017-12-18 15:17:17,739 [salt.minion      ][INFO    ][25350] Starting a new job with PID 25350
2017-12-18 15:17:17,748 [salt.loaded.int.module.cmdmod][INFO    ][25350] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-18 15:17:17,988 [salt.minion      ][INFO    ][25350] Returning information for job: 20171218151717718074
2017-12-18 15:32:00,768 [salt.utils.schedule][INFO    ][7500] Running scheduled job: __mine_interval
2017-12-18 16:23:31,248 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command test.ping with jid 20171218162331245596
2017-12-18 16:23:31,277 [salt.minion      ][INFO    ][26258] Starting a new job with PID 26258
2017-12-18 16:23:31,338 [salt.minion      ][INFO    ][26258] Returning information for job: 20171218162331245596
2017-12-18 16:23:36,369 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command state.sls with jid 20171218162336366257
2017-12-18 16:23:36,389 [salt.minion      ][INFO    ][26263] Starting a new job with PID 26263
2017-12-18 16:23:36,887 [salt.state       ][INFO    ][26263] Loading fresh modules for state activity
2017-12-18 16:23:36,931 [salt.fileclient  ][INFO    ][26263] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-18 16:23:36,958 [salt.fileclient  ][INFO    ][26263] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-18 16:23:36,995 [salt.fileclient  ][INFO    ][26263] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-18 16:23:37,330 [salt.state       ][INFO    ][26263] Running state [lsof] at time 16:23:37.330207
2017-12-18 16:23:37,330 [salt.state       ][INFO    ][26263] Executing state pkg.installed for lsof
2017-12-18 16:23:37,331 [salt.loaded.int.module.cmdmod][INFO    ][26263] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 16:23:37,683 [salt.state       ][INFO    ][26263] Package lsof is already installed
2017-12-18 16:23:37,683 [salt.state       ][INFO    ][26263] Completed state [lsof] at time 16:23:37.682983 duration_in_ms=352.776
2017-12-18 16:23:37,683 [salt.state       ][INFO    ][26263] Running state [keepalived] at time 16:23:37.683187
2017-12-18 16:23:37,683 [salt.state       ][INFO    ][26263] Executing state pkg.installed for keepalived
2017-12-18 16:23:37,686 [salt.state       ][INFO    ][26263] Package keepalived is already installed
2017-12-18 16:23:37,686 [salt.state       ][INFO    ][26263] Completed state [keepalived] at time 16:23:37.686210 duration_in_ms=3.022
2017-12-18 16:23:37,688 [salt.state       ][INFO    ][26263] Running state [/etc/keepalived/keepalived.conf] at time 16:23:37.687687
2017-12-18 16:23:37,688 [salt.state       ][INFO    ][26263] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-18 16:23:37,711 [salt.fileclient  ][INFO    ][26263] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-18 16:23:37,745 [salt.fileclient  ][INFO    ][26263] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-18 16:23:37,750 [salt.state       ][INFO    ][26263] File /etc/keepalived/keepalived.conf is in the correct state
2017-12-18 16:23:37,750 [salt.state       ][INFO    ][26263] Completed state [/etc/keepalived/keepalived.conf] at time 16:23:37.750017 duration_in_ms=62.33
2017-12-18 16:23:37,751 [salt.state       ][INFO    ][26263] Running state [keepalived] at time 16:23:37.750579
2017-12-18 16:23:37,751 [salt.state       ][INFO    ][26263] Executing state service.running for keepalived
2017-12-18 16:23:37,751 [salt.loaded.int.module.cmdmod][INFO    ][26263] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-18 16:23:37,774 [salt.loaded.int.module.cmdmod][INFO    ][26263] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-18 16:23:37,786 [salt.loaded.int.module.cmdmod][INFO    ][26263] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-18 16:23:37,798 [salt.state       ][INFO    ][26263] The service keepalived is already running
2017-12-18 16:23:37,798 [salt.state       ][INFO    ][26263] Completed state [keepalived] at time 16:23:37.797956 duration_in_ms=47.377
2017-12-18 16:23:37,799 [salt.minion      ][INFO    ][26263] Returning information for job: 20171218162336366257
2017-12-18 16:24:10,526 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command pillar.get with jid 20171218162410525696
2017-12-18 16:24:10,559 [salt.minion      ][INFO    ][26290] Starting a new job with PID 26290
2017-12-18 16:24:10,575 [salt.minion      ][INFO    ][26290] Returning information for job: 20171218162410525696
2017-12-18 16:25:13,096 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command state.sls with jid 20171218162513095619
2017-12-18 16:25:13,114 [salt.minion      ][INFO    ][26297] Starting a new job with PID 26297
2017-12-18 16:25:15,606 [salt.state       ][INFO    ][26297] Loading fresh modules for state activity
2017-12-18 16:25:15,643 [salt.fileclient  ][INFO    ][26297] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-18 16:25:15,675 [salt.fileclient  ][INFO    ][26297] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-18 16:25:15,999 [salt.state       ][INFO    ][26297] Running state [attr] at time 16:25:15.999322
2017-12-18 16:25:15,1000 [salt.state       ][INFO    ][26297] Executing state pkg.installed for attr
2017-12-18 16:25:15,1000 [salt.loaded.int.module.cmdmod][INFO    ][26297] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 16:25:16,300 [salt.state       ][INFO    ][26297] Package attr is already installed
2017-12-18 16:25:16,301 [salt.state       ][INFO    ][26297] Completed state [attr] at time 16:25:16.300688 duration_in_ms=301.365
2017-12-18 16:25:16,301 [salt.state       ][INFO    ][26297] Running state [glusterfs-server] at time 16:25:16.300893
2017-12-18 16:25:16,301 [salt.state       ][INFO    ][26297] Executing state pkg.installed for glusterfs-server
2017-12-18 16:25:16,304 [salt.state       ][INFO    ][26297] Package glusterfs-server is already installed
2017-12-18 16:25:16,304 [salt.state       ][INFO    ][26297] Completed state [glusterfs-server] at time 16:25:16.303914 duration_in_ms=3.02
2017-12-18 16:25:16,304 [salt.state       ][INFO    ][26297] Running state [bc] at time 16:25:16.304091
2017-12-18 16:25:16,304 [salt.state       ][INFO    ][26297] Executing state pkg.installed for bc
2017-12-18 16:25:16,307 [salt.state       ][INFO    ][26297] Package bc is already installed
2017-12-18 16:25:16,307 [salt.state       ][INFO    ][26297] Completed state [bc] at time 16:25:16.307011 duration_in_ms=2.92
2017-12-18 16:25:16,308 [salt.state       ][INFO    ][26297] Running state [glusterd] at time 16:25:16.307695
2017-12-18 16:25:16,308 [salt.state       ][INFO    ][26297] Executing state service.running for glusterd
2017-12-18 16:25:16,308 [salt.loaded.int.module.cmdmod][INFO    ][26297] Executing command ['systemctl', 'status', 'glusterd.service', '-n', '0'] in directory '/root'
2017-12-18 16:25:16,335 [salt.loaded.int.module.cmdmod][INFO    ][26297] Executing command ['systemctl', 'is-active', 'glusterd.service'] in directory '/root'
2017-12-18 16:25:16,348 [salt.loaded.int.module.cmdmod][INFO    ][26297] Executing command ['systemctl', 'is-enabled', 'glusterd.service'] in directory '/root'
2017-12-18 16:25:16,360 [salt.state       ][INFO    ][26297] The service glusterd is already running
2017-12-18 16:25:16,361 [salt.state       ][INFO    ][26297] Completed state [glusterd] at time 16:25:16.360522 duration_in_ms=52.827
2017-12-18 16:25:16,362 [salt.state       ][INFO    ][26297] Running state [/etc/systemd/system/glusterd.service.d/override.conf] at time 16:25:16.362156
2017-12-18 16:25:16,362 [salt.state       ][INFO    ][26297] Executing state file.managed for /etc/systemd/system/glusterd.service.d/override.conf
2017-12-18 16:25:16,372 [salt.state       ][INFO    ][26297] File /etc/systemd/system/glusterd.service.d/override.conf is in the correct state
2017-12-18 16:25:16,373 [salt.state       ][INFO    ][26297] Completed state [/etc/systemd/system/glusterd.service.d/override.conf] at time 16:25:16.372481 duration_in_ms=10.325
2017-12-18 16:25:16,373 [salt.state       ][INFO    ][26297] Running state [/srv/glusterfs/glance] at time 16:25:16.372653
2017-12-18 16:25:16,373 [salt.state       ][INFO    ][26297] Executing state file.directory for /srv/glusterfs/glance
2017-12-18 16:25:16,373 [salt.state       ][INFO    ][26297] Directory /srv/glusterfs/glance is in the correct state
2017-12-18 16:25:16,373 [salt.state       ][INFO    ][26297] Completed state [/srv/glusterfs/glance] at time 16:25:16.373377 duration_in_ms=0.724
2017-12-18 16:25:16,374 [salt.state       ][INFO    ][26297] Running state [/srv/glusterfs/keystone-keys] at time 16:25:16.373545
2017-12-18 16:25:16,374 [salt.state       ][INFO    ][26297] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-18 16:25:16,374 [salt.state       ][INFO    ][26297] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-18 16:25:16,374 [salt.state       ][INFO    ][26297] Completed state [/srv/glusterfs/keystone-keys] at time 16:25:16.374252 duration_in_ms=0.706
2017-12-18 16:25:16,374 [salt.state       ][INFO    ][26297] Running state [/srv/glusterfs/nova_instances] at time 16:25:16.374417
2017-12-18 16:25:16,375 [salt.state       ][INFO    ][26297] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-18 16:25:16,375 [salt.state       ][INFO    ][26297] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-18 16:25:16,375 [salt.state       ][INFO    ][26297] Completed state [/srv/glusterfs/nova_instances] at time 16:25:16.375122 duration_in_ms=0.705
2017-12-18 16:25:16,375 [salt.state       ][INFO    ][26297] Running state [/srv/glusterfs/keystone-credential-keys] at time 16:25:16.375288
2017-12-18 16:25:16,375 [salt.state       ][INFO    ][26297] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-18 16:25:16,376 [salt.state       ][INFO    ][26297] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-18 16:25:16,376 [salt.state       ][INFO    ][26297] Completed state [/srv/glusterfs/keystone-credential-keys] at time 16:25:16.376006 duration_in_ms=0.718
2017-12-18 16:25:16,377 [salt.minion      ][INFO    ][26297] Returning information for job: 20171218162513095619
2017-12-18 16:25:17,747 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command test.ping with jid 20171218162517746649
2017-12-18 16:25:17,765 [salt.minion      ][INFO    ][26317] Starting a new job with PID 26317
2017-12-18 16:25:17,823 [salt.minion      ][INFO    ][26317] Returning information for job: 20171218162517746649
2017-12-18 16:25:25,457 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command state.sls with jid 20171218162525456181
2017-12-18 16:25:25,475 [salt.minion      ][INFO    ][26322] Starting a new job with PID 26322
2017-12-18 16:25:25,955 [salt.state       ][INFO    ][26322] Loading fresh modules for state activity
2017-12-18 16:25:25,995 [salt.fileclient  ][INFO    ][26322] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-18 16:25:26,050 [salt.fileclient  ][INFO    ][26322] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-18 16:25:26,147 [salt.fileclient  ][INFO    ][26322] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-18 16:25:26,167 [salt.fileclient  ][INFO    ][26322] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-18 16:25:26,467 [salt.state       ][INFO    ][26322] Running state [attr] at time 16:25:26.466889
2017-12-18 16:25:26,467 [salt.state       ][INFO    ][26322] Executing state pkg.installed for attr
2017-12-18 16:25:26,468 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-18 16:25:26,791 [salt.state       ][INFO    ][26322] Package attr is already installed
2017-12-18 16:25:26,791 [salt.state       ][INFO    ][26322] Completed state [attr] at time 16:25:26.790896 duration_in_ms=324.007
2017-12-18 16:25:26,791 [salt.state       ][INFO    ][26322] Running state [glusterfs-server] at time 16:25:26.791103
2017-12-18 16:25:26,791 [salt.state       ][INFO    ][26322] Executing state pkg.installed for glusterfs-server
2017-12-18 16:25:26,794 [salt.state       ][INFO    ][26322] Package glusterfs-server is already installed
2017-12-18 16:25:26,794 [salt.state       ][INFO    ][26322] Completed state [glusterfs-server] at time 16:25:26.794142 duration_in_ms=3.04
2017-12-18 16:25:26,794 [salt.state       ][INFO    ][26322] Running state [bc] at time 16:25:26.794298
2017-12-18 16:25:26,794 [salt.state       ][INFO    ][26322] Executing state pkg.installed for bc
2017-12-18 16:25:26,797 [salt.state       ][INFO    ][26322] Package bc is already installed
2017-12-18 16:25:26,797 [salt.state       ][INFO    ][26322] Completed state [bc] at time 16:25:26.797241 duration_in_ms=2.944
2017-12-18 16:25:26,798 [salt.state       ][INFO    ][26322] Running state [glusterd] at time 16:25:26.798086
2017-12-18 16:25:26,798 [salt.state       ][INFO    ][26322] Executing state service.running for glusterd
2017-12-18 16:25:26,799 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command ['systemctl', 'status', 'glusterd.service', '-n', '0'] in directory '/root'
2017-12-18 16:25:26,825 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command ['systemctl', 'is-active', 'glusterd.service'] in directory '/root'
2017-12-18 16:25:26,838 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command ['systemctl', 'is-enabled', 'glusterd.service'] in directory '/root'
2017-12-18 16:25:26,849 [salt.state       ][INFO    ][26322] The service glusterd is already running
2017-12-18 16:25:26,849 [salt.state       ][INFO    ][26322] Completed state [glusterd] at time 16:25:26.849116 duration_in_ms=51.029
2017-12-18 16:25:26,851 [salt.state       ][INFO    ][26322] Running state [/etc/systemd/system/glusterd.service.d/override.conf] at time 16:25:26.850828
2017-12-18 16:25:26,851 [salt.state       ][INFO    ][26322] Executing state file.managed for /etc/systemd/system/glusterd.service.d/override.conf
2017-12-18 16:25:26,864 [salt.state       ][INFO    ][26322] File /etc/systemd/system/glusterd.service.d/override.conf is in the correct state
2017-12-18 16:25:26,864 [salt.state       ][INFO    ][26322] Completed state [/etc/systemd/system/glusterd.service.d/override.conf] at time 16:25:26.864457 duration_in_ms=13.629
2017-12-18 16:25:26,865 [salt.state       ][INFO    ][26322] Running state [/srv/glusterfs/glance] at time 16:25:26.864648
2017-12-18 16:25:26,865 [salt.state       ][INFO    ][26322] Executing state file.directory for /srv/glusterfs/glance
2017-12-18 16:25:26,865 [salt.state       ][INFO    ][26322] Directory /srv/glusterfs/glance is in the correct state
2017-12-18 16:25:26,865 [salt.state       ][INFO    ][26322] Completed state [/srv/glusterfs/glance] at time 16:25:26.865440 duration_in_ms=0.792
2017-12-18 16:25:26,866 [salt.state       ][INFO    ][26322] Running state [/srv/glusterfs/keystone-keys] at time 16:25:26.865629
2017-12-18 16:25:26,866 [salt.state       ][INFO    ][26322] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-18 16:25:26,866 [salt.state       ][INFO    ][26322] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-18 16:25:26,866 [salt.state       ][INFO    ][26322] Completed state [/srv/glusterfs/keystone-keys] at time 16:25:26.866426 duration_in_ms=0.796
2017-12-18 16:25:26,867 [salt.state       ][INFO    ][26322] Running state [/srv/glusterfs/nova_instances] at time 16:25:26.866609
2017-12-18 16:25:26,867 [salt.state       ][INFO    ][26322] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-18 16:25:26,867 [salt.state       ][INFO    ][26322] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-18 16:25:26,867 [salt.state       ][INFO    ][26322] Completed state [/srv/glusterfs/nova_instances] at time 16:25:26.867397 duration_in_ms=0.788
2017-12-18 16:25:26,868 [salt.state       ][INFO    ][26322] Running state [/srv/glusterfs/keystone-credential-keys] at time 16:25:26.867586
2017-12-18 16:25:26,868 [salt.state       ][INFO    ][26322] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-18 16:25:26,868 [salt.state       ][INFO    ][26322] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-18 16:25:26,868 [salt.state       ][INFO    ][26322] Completed state [/srv/glusterfs/keystone-credential-keys] at time 16:25:26.868382 duration_in_ms=0.796
2017-12-18 16:25:26,958 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command ['git', '--version'] in directory '/root'
2017-12-18 16:25:27,006 [salt.state       ][INFO    ][26322] Running state [sleep 5] at time 16:25:27.005837
2017-12-18 16:25:27,006 [salt.state       ][INFO    ][26322] Executing state cmd.wait for sleep 5
2017-12-18 16:25:27,006 [salt.state       ][INFO    ][26322] No changes made for sleep 5
2017-12-18 16:25:27,006 [salt.state       ][INFO    ][26322] Completed state [sleep 5] at time 16:25:27.006427 duration_in_ms=0.592
2017-12-18 16:25:27,007 [salt.state       ][INFO    ][26322] Running state [10.167.4.141] at time 16:25:27.006848
2017-12-18 16:25:27,007 [salt.state       ][INFO    ][26322] Executing state glusterfs.peered for 10.167.4.141
2017-12-18 16:25:27,007 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:27,022 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:27,130 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:27,146 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:27,249 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:27,265 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:27,377 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:27,397 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:27,512 [salt.state       ][INFO    ][26322] Peering with localhost is not needed
2017-12-18 16:25:27,513 [salt.state       ][INFO    ][26322] Completed state [10.167.4.141] at time 16:25:27.512811 duration_in_ms=505.961
2017-12-18 16:25:27,519 [salt.state       ][INFO    ][26322] Running state [10.167.4.142] at time 16:25:27.518931
2017-12-18 16:25:27,520 [salt.state       ][INFO    ][26322] Executing state glusterfs.peered for 10.167.4.142
2017-12-18 16:25:27,521 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:27,539 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:27,632 [salt.state       ][INFO    ][26322] Host 10.167.4.142 already peered
2017-12-18 16:25:27,632 [salt.state       ][INFO    ][26322] Completed state [10.167.4.142] at time 16:25:27.632227 duration_in_ms=113.293
2017-12-18 16:25:27,638 [salt.state       ][INFO    ][26322] Running state [10.167.4.143] at time 16:25:27.638103
2017-12-18 16:25:27,639 [salt.state       ][INFO    ][26322] Executing state glusterfs.peered for 10.167.4.143
2017-12-18 16:25:27,640 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:27,655 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:27,735 [salt.state       ][INFO    ][26322] Host 10.167.4.143 already peered
2017-12-18 16:25:27,735 [salt.state       ][INFO    ][26322] Completed state [10.167.4.143] at time 16:25:27.735244 duration_in_ms=97.139
2017-12-18 16:25:27,737 [salt.state       ][INFO    ][26322] Running state [glance] at time 16:25:27.737397
2017-12-18 16:25:27,738 [salt.state       ][INFO    ][26322] Executing state glusterfs.created for glance
2017-12-18 16:25:27,739 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:27,757 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:27,870 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:27,884 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:27,993 [salt.state       ][INFO    ][26322] Volume glance already exists and is started.
2017-12-18 16:25:27,994 [salt.state       ][INFO    ][26322] Completed state [glance] at time 16:25:27.993550 duration_in_ms=256.151
2017-12-18 16:25:28,003 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 16:25:28.002437
2017-12-18 16:25:28,003 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-18 16:25:28,004 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-18 16:25:28,122 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:28,123 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 16:25:28.122599 duration_in_ms=120.16
2017-12-18 16:25:28,124 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 16:25:28.123970
2017-12-18 16:25:28,125 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-18 16:25:28,126 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-18 16:25:28,236 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:28,237 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 16:25:28.236696 duration_in_ms=112.726
2017-12-18 16:25:28,238 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 16:25:28.237647
2017-12-18 16:25:28,238 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-18 16:25:28,239 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-18 16:25:28,349 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:28,349 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 16:25:28.348999 duration_in_ms=111.351
2017-12-18 16:25:28,350 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 16:25:28.349843
2017-12-18 16:25:28,350 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-18 16:25:28,351 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-18 16:25:28,462 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:28,463 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 16:25:28.462530 duration_in_ms=112.685
2017-12-18 16:25:28,464 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 16:25:28.463827
2017-12-18 16:25:28,465 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-18 16:25:28,466 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-18 16:25:28,571 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:28,572 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 16:25:28.571558 duration_in_ms=107.731
2017-12-18 16:25:28,572 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 16:25:28.572311
2017-12-18 16:25:28,573 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-18 16:25:28,573 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-18 16:25:28,688 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:28,688 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 16:25:28.687988 duration_in_ms=115.675
2017-12-18 16:25:28,691 [salt.state       ][INFO    ][26322] Running state [glance] at time 16:25:28.690640
2017-12-18 16:25:28,691 [salt.state       ][INFO    ][26322] Executing state glusterfs.started for glance
2017-12-18 16:25:28,692 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:28,707 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:28,815 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:28,833 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:28,945 [salt.state       ][INFO    ][26322] Volume glance is already started
2017-12-18 16:25:28,946 [salt.state       ][INFO    ][26322] Completed state [glance] at time 16:25:28.945804 duration_in_ms=255.163
2017-12-18 16:25:28,948 [salt.state       ][INFO    ][26322] Running state [keystone-keys] at time 16:25:28.947944
2017-12-18 16:25:28,949 [salt.state       ][INFO    ][26322] Executing state glusterfs.created for keystone-keys
2017-12-18 16:25:28,949 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:28,966 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:29,077 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:29,096 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:29,217 [salt.state       ][INFO    ][26322] Volume keystone-keys already exists and is started.
2017-12-18 16:25:29,217 [salt.state       ][INFO    ][26322] Completed state [keystone-keys] at time 16:25:29.217274 duration_in_ms=269.33
2017-12-18 16:25:29,226 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 16:25:29.226131
2017-12-18 16:25:29,227 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-18 16:25:29,228 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-18 16:25:29,342 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:29,342 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 16:25:29.342178 duration_in_ms=116.047
2017-12-18 16:25:29,343 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 16:25:29.343316
2017-12-18 16:25:29,344 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-18 16:25:29,345 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-18 16:25:29,455 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:29,456 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 16:25:29.455679 duration_in_ms=112.361
2017-12-18 16:25:29,457 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 16:25:29.456974
2017-12-18 16:25:29,458 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-18 16:25:29,459 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-18 16:25:29,565 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:29,572 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 16:25:29.572301 duration_in_ms=115.326
2017-12-18 16:25:29,573 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 16:25:29.573162
2017-12-18 16:25:29,574 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-18 16:25:29,574 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-18 16:25:29,683 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:29,684 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 16:25:29.683512 duration_in_ms=110.349
2017-12-18 16:25:29,685 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 16:25:29.684636
2017-12-18 16:25:29,685 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-18 16:25:29,687 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-18 16:25:29,780 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:29,781 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 16:25:29.780939 duration_in_ms=96.302
2017-12-18 16:25:29,782 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 16:25:29.782137
2017-12-18 16:25:29,783 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-18 16:25:29,784 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-18 16:25:29,897 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:29,898 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 16:25:29.897492 duration_in_ms=115.354
2017-12-18 16:25:29,901 [salt.state       ][INFO    ][26322] Running state [keystone-keys] at time 16:25:29.900432
2017-12-18 16:25:29,901 [salt.state       ][INFO    ][26322] Executing state glusterfs.started for keystone-keys
2017-12-18 16:25:29,902 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:29,919 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:30,026 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:30,042 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:30,158 [salt.state       ][INFO    ][26322] Volume keystone-keys is already started
2017-12-18 16:25:30,159 [salt.state       ][INFO    ][26322] Completed state [keystone-keys] at time 16:25:30.158396 duration_in_ms=257.962
2017-12-18 16:25:30,161 [salt.state       ][INFO    ][26322] Running state [nova_instances] at time 16:25:30.160835
2017-12-18 16:25:30,161 [salt.state       ][INFO    ][26322] Executing state glusterfs.created for nova_instances
2017-12-18 16:25:30,162 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:30,179 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:30,279 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:30,299 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:30,419 [salt.state       ][INFO    ][26322] Volume nova_instances already exists and is started.
2017-12-18 16:25:30,419 [salt.state       ][INFO    ][26322] Completed state [nova_instances] at time 16:25:30.418995 duration_in_ms=258.16
2017-12-18 16:25:30,427 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 16:25:30.427371
2017-12-18 16:25:30,428 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-18 16:25:30,429 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-18 16:25:30,539 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:30,539 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 16:25:30.539094 duration_in_ms=111.722
2017-12-18 16:25:30,540 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 16:25:30.539972
2017-12-18 16:25:30,540 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-18 16:25:30,541 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-18 16:25:30,634 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:30,635 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 16:25:30.634614 duration_in_ms=94.64
2017-12-18 16:25:30,636 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 16:25:30.635771
2017-12-18 16:25:30,636 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-18 16:25:30,637 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-18 16:25:30,744 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:30,745 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 16:25:30.744923 duration_in_ms=109.152
2017-12-18 16:25:30,746 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 16:25:30.746031
2017-12-18 16:25:30,747 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-18 16:25:30,748 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-18 16:25:30,857 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:30,858 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 16:25:30.857591 duration_in_ms=111.559
2017-12-18 16:25:30,859 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 16:25:30.858773
2017-12-18 16:25:30,859 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-18 16:25:30,861 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-18 16:25:30,969 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:30,970 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 16:25:30.969423 duration_in_ms=110.648
2017-12-18 16:25:30,971 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 16:25:30.970575
2017-12-18 16:25:30,971 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-18 16:25:30,972 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-18 16:25:31,050 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:31,050 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 16:25:31.050206 duration_in_ms=79.63
2017-12-18 16:25:31,053 [salt.state       ][INFO    ][26322] Running state [nova_instances] at time 16:25:31.052987
2017-12-18 16:25:31,054 [salt.state       ][INFO    ][26322] Executing state glusterfs.started for nova_instances
2017-12-18 16:25:31,054 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:31,070 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:31,183 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:31,201 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:31,315 [salt.state       ][INFO    ][26322] Volume nova_instances is already started
2017-12-18 16:25:31,315 [salt.state       ][INFO    ][26322] Completed state [nova_instances] at time 16:25:31.315083 duration_in_ms=262.095
2017-12-18 16:25:31,318 [salt.state       ][INFO    ][26322] Running state [keystone-credential-keys] at time 16:25:31.317522
2017-12-18 16:25:31,318 [salt.state       ][INFO    ][26322] Executing state glusterfs.created for keystone-credential-keys
2017-12-18 16:25:31,319 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:31,337 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:31,454 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:31,472 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:31,585 [salt.state       ][INFO    ][26322] Volume keystone-credential-keys already exists and is started.
2017-12-18 16:25:31,585 [salt.state       ][INFO    ][26322] Completed state [keystone-credential-keys] at time 16:25:31.585319 duration_in_ms=267.797
2017-12-18 16:25:31,592 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 16:25:31.592138
2017-12-18 16:25:31,593 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-18 16:25:31,593 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-18 16:25:31,685 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:31,685 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 16:25:31.685350 duration_in_ms=93.211
2017-12-18 16:25:31,687 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 16:25:31.686509
2017-12-18 16:25:31,687 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-18 16:25:31,688 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-18 16:25:31,758 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:31,758 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 16:25:31.757960 duration_in_ms=71.451
2017-12-18 16:25:31,759 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 16:25:31.758969
2017-12-18 16:25:31,759 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-18 16:25:31,760 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-18 16:25:31,857 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:31,858 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 16:25:31.857839 duration_in_ms=98.87
2017-12-18 16:25:31,859 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 16:25:31.858921
2017-12-18 16:25:31,859 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-18 16:25:31,861 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-18 16:25:31,944 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:31,944 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 16:25:31.944052 duration_in_ms=85.131
2017-12-18 16:25:31,945 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 16:25:31.945109
2017-12-18 16:25:31,946 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-18 16:25:31,947 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-18 16:25:32,059 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:32,059 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 16:25:32.059240 duration_in_ms=114.13
2017-12-18 16:25:32,061 [salt.state       ][INFO    ][26322] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 16:25:32.060557
2017-12-18 16:25:32,061 [salt.state       ][INFO    ][26322] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-18 16:25:32,062 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-18 16:25:32,176 [salt.state       ][INFO    ][26322] unless execution succeeded
2017-12-18 16:25:32,177 [salt.state       ][INFO    ][26322] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 16:25:32.176950 duration_in_ms=116.392
2017-12-18 16:25:32,180 [salt.state       ][INFO    ][26322] Running state [keystone-credential-keys] at time 16:25:32.179974
2017-12-18 16:25:32,181 [salt.state       ][INFO    ][26322] Executing state glusterfs.started for keystone-credential-keys
2017-12-18 16:25:32,182 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:32,199 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:32,308 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --version' in directory '/root'
2017-12-18 16:25:32,324 [salt.loaded.int.module.cmdmod][INFO    ][26322] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-18 16:25:32,446 [salt.state       ][INFO    ][26322] Volume keystone-credential-keys is already started
2017-12-18 16:25:32,446 [salt.state       ][INFO    ][26322] Completed state [keystone-credential-keys] at time 16:25:32.446032 duration_in_ms=266.058
2017-12-18 16:25:32,450 [salt.minion      ][INFO    ][26322] Returning information for job: 20171218162525456181
2017-12-18 16:25:41,027 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command test.ping with jid 20171218162541026621
2017-12-18 16:25:41,045 [salt.minion      ][INFO    ][26898] Starting a new job with PID 26898
2017-12-18 16:25:41,102 [salt.minion      ][INFO    ][26898] Returning information for job: 20171218162541026621
2017-12-18 16:25:41,626 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command cmd.run with jid 20171218162541624224
2017-12-18 16:25:41,644 [salt.minion      ][INFO    ][26903] Starting a new job with PID 26903
2017-12-18 16:25:41,651 [salt.loaded.int.module.cmdmod][INFO    ][26903] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-18 16:25:41,884 [salt.minion      ][INFO    ][26903] Returning information for job: 20171218162541624224
2017-12-18 16:32:00,769 [salt.utils.schedule][INFO    ][7500] Running scheduled job: __mine_interval
2017-12-18 16:54:38,779 [salt.minion      ][INFO    ][7500] User sudo_ubuntu Executing command cp.push_dir with jid 20171218165438775565
2017-12-18 16:54:38,804 [salt.minion      ][INFO    ][27131] Starting a new job with PID 27131
