2017-12-17 01:49:03,740 [salt.cli.daemons ][WARNING ][2418] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-17 02:07:25,128 [salt.state       ][ERROR   ][3768] No contents found in top file
2017-12-17 02:08:53,235 [salt.utils.parsers][WARNING ][2418] Minion received a SIGTERM. Exiting.
2017-12-17 02:11:17,839 [salt.cli.daemons ][WARNING ][3164] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-17 02:11:54,800 [py.warnings      ][WARNING ][3308] /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-17 02:12:39,716 [salt.loaded.int.module.cmdmod][ERROR   ][3308] 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-17 02:12:41,878 [salt.loaded.int.module.cmdmod][INFO    ][7741] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-17 02:12:41,886 [salt.loaded.int.module.cmdmod][INFO    ][7741] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-17 02:12:41,897 [salt.loaded.int.module.cmdmod][INFO    ][7741] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-17 02:12:41,906 [salt.utils.parsers][WARNING ][3164] Minion received a SIGTERM. Exiting.
2017-12-17 02:12:42,164 [salt.cli.daemons ][INFO    ][7812] Setting up the Salt Minion "kvm03.baremetal-mcp-pike-ovs-ha.local"
2017-12-17 02:12:42,680 [salt.minion      ][INFO    ][7812] Creating minion process manager
2017-12-17 02:12:42,680 [salt.cli.daemons ][WARNING ][7812] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-17 02:12:42,680 [salt.cli.daemons ][INFO    ][7812] The Salt Minion is starting up
2017-12-17 02:12:42,680 [salt.minion      ][INFO    ][7812] Minion is starting as user 'root'
2017-12-17 02:12:42,681 [salt.utils.event ][INFO    ][7812] Starting pull socket on /var/run/salt/minion/minion_event_21700b8c78_pull.ipc
2017-12-17 02:12:43,584 [salt.loaded.int.module.cmdmod][INFO    ][7812] Executing command ['date', '+%z'] in directory '/root'
2017-12-17 02:12:43,593 [salt.utils.schedule][INFO    ][7812] Updating job settings for scheduled job: __mine_interval
2017-12-17 02:12:43,595 [salt.minion      ][INFO    ][7812] Added mine.update to scheduler
2017-12-17 02:12:43,621 [salt.minion      ][INFO    ][7812] Minion is ready to receive requests!
2017-12-17 02:12:43,752 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command pkg.upgrade with jid 20171217021243743345
2017-12-17 02:12:43,765 [salt.minion      ][INFO    ][7899] Starting a new job with PID 7899
2017-12-17 02:12:43,780 [salt.loaded.int.module.cmdmod][INFO    ][7899] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:12:44,072 [salt.loaded.int.module.cmdmod][INFO    ][7899] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2017-12-17 02:12:44,622 [salt.utils.schedule][INFO    ][7812] Running scheduled job: __mine_interval
2017-12-17 02:12:53,825 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021253817736
2017-12-17 02:12:53,839 [salt.minion      ][INFO    ][8110] Starting a new job with PID 8110
2017-12-17 02:12:53,850 [salt.minion      ][INFO    ][8110] Returning information for job: 20171217021253817736
2017-12-17 02:13:01,622 [salt.loaded.int.module.cmdmod][INFO    ][7899] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:13:01,644 [salt.minion      ][INFO    ][7899] Returning information for job: 20171217021243743345
2017-12-17 02:13:15,220 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command state.sls with jid 20171217021315212113
2017-12-17 02:13:15,236 [salt.minion      ][INFO    ][8770] Starting a new job with PID 8770
2017-12-17 02:13:16,813 [salt.state       ][INFO    ][8770] Loading fresh modules for state activity
2017-12-17 02:13:16,839 [salt.fileclient  ][INFO    ][8770] Fetching file from saltenv 'base', ** done ** 'libvirt/init.sls'
2017-12-17 02:13:16,861 [salt.fileclient  ][INFO    ][8770] Fetching file from saltenv 'base', ** done ** 'libvirt/server/init.sls'
2017-12-17 02:13:16,875 [salt.fileclient  ][INFO    ][8770] Fetching file from saltenv 'base', ** done ** 'libvirt/server/service.sls'
2017-12-17 02:13:16,896 [salt.fileclient  ][INFO    ][8770] Fetching file from saltenv 'base', ** done ** 'libvirt/map.jinja'
2017-12-17 02:13:16,919 [salt.fileclient  ][INFO    ][8770] Fetching file from saltenv 'base', ** done ** 'libvirt/server/network.sls'
2017-12-17 02:13:16,943 [salt.fileclient  ][INFO    ][8770] Fetching file from saltenv 'base', ** done ** 'libvirt/map.jinja'
2017-12-17 02:13:16,962 [salt.fileclient  ][INFO    ][8770] Fetching file from saltenv 'base', ** done ** 'libvirt/server/pool.sls'
2017-12-17 02:13:16,984 [salt.fileclient  ][INFO    ][8770] Fetching file from saltenv 'base', ** done ** 'libvirt/map.jinja'
2017-12-17 02:13:17,266 [salt.state       ][INFO    ][8770] Running state [libvirt0] at time 02:13:17.266368
2017-12-17 02:13:17,267 [salt.state       ][INFO    ][8770] Executing state pkg.installed for libvirt0
2017-12-17 02:13:17,267 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:13:17,537 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-17 02:13:19,425 [salt.loaded.int.module.cmdmod][INFO    ][8770] 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-17 02:13:25,343 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021325321405
2017-12-17 02:13:25,357 [salt.minion      ][INFO    ][9216] Starting a new job with PID 9216
2017-12-17 02:13:25,371 [salt.minion      ][INFO    ][9216] Returning information for job: 20171217021325321405
2017-12-17 02:13:27,576 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:13:27,598 [salt.state       ][INFO    ][8770] 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-17 02:13:27,607 [salt.state       ][INFO    ][8770] Loading fresh modules for state activity
2017-12-17 02:13:27,619 [salt.state       ][INFO    ][8770] Completed state [libvirt0] at time 02:13:27.619100 duration_in_ms=10352.732
2017-12-17 02:13:27,624 [salt.state       ][INFO    ][8770] Running state [pm-utils] at time 02:13:27.624338
2017-12-17 02:13:27,625 [salt.state       ][INFO    ][8770] Executing state pkg.installed for pm-utils
2017-12-17 02:13:27,807 [salt.loaded.int.module.cmdmod][INFO    ][8770] 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-17 02:13:31,669 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:13:31,692 [salt.state       ][INFO    ][8770] 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-17 02:13:31,699 [salt.state       ][INFO    ][8770] Loading fresh modules for state activity
2017-12-17 02:13:31,713 [salt.state       ][INFO    ][8770] Completed state [pm-utils] at time 02:13:31.712652 duration_in_ms=4088.313
2017-12-17 02:13:31,717 [salt.state       ][INFO    ][8770] Running state [python-libvirt] at time 02:13:31.717320
2017-12-17 02:13:31,717 [salt.state       ][INFO    ][8770] Executing state pkg.installed for python-libvirt
2017-12-17 02:13:31,922 [salt.loaded.int.module.cmdmod][INFO    ][8770] 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-17 02:13:35,542 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021335532810
2017-12-17 02:13:35,556 [salt.minion      ][INFO    ][9890] Starting a new job with PID 9890
2017-12-17 02:13:35,567 [salt.minion      ][INFO    ][9890] Returning information for job: 20171217021335532810
2017-12-17 02:13:45,758 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021345739112
2017-12-17 02:13:45,773 [salt.minion      ][INFO    ][10152] Starting a new job with PID 10152
2017-12-17 02:13:45,786 [salt.minion      ][INFO    ][10152] Returning information for job: 20171217021345739112
2017-12-17 02:13:55,953 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021355940912
2017-12-17 02:13:55,967 [salt.minion      ][INFO    ][10991] Starting a new job with PID 10991
2017-12-17 02:13:55,978 [salt.minion      ][INFO    ][10991] Returning information for job: 20171217021355940912
2017-12-17 02:14:04,047 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:14:04,071 [salt.state       ][INFO    ][8770] 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-17 02:14:04,080 [salt.state       ][INFO    ][8770] Loading fresh modules for state activity
2017-12-17 02:14:04,093 [salt.state       ][INFO    ][8770] Completed state [python-libvirt] at time 02:14:04.092699 duration_in_ms=32375.379
2017-12-17 02:14:04,097 [salt.state       ][INFO    ][8770] Running state [libvirt-bin] at time 02:14:04.097162
2017-12-17 02:14:04,097 [salt.state       ][INFO    ][8770] Executing state pkg.installed for libvirt-bin
2017-12-17 02:14:04,365 [salt.loaded.int.module.cmdmod][INFO    ][8770] 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-17 02:14:06,160 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021406152520
2017-12-17 02:14:06,175 [salt.minion      ][INFO    ][11265] Starting a new job with PID 11265
2017-12-17 02:14:06,185 [salt.minion      ][INFO    ][11265] Returning information for job: 20171217021406152520
2017-12-17 02:14:16,279 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021416271459
2017-12-17 02:14:16,292 [salt.minion      ][INFO    ][12512] Starting a new job with PID 12512
2017-12-17 02:14:16,302 [salt.minion      ][INFO    ][12512] Returning information for job: 20171217021416271459
2017-12-17 02:14:17,156 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:14:17,180 [salt.state       ][INFO    ][8770] 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-17 02:14:17,187 [salt.state       ][INFO    ][8770] Loading fresh modules for state activity
2017-12-17 02:14:17,200 [salt.state       ][INFO    ][8770] Completed state [libvirt-bin] at time 02:14:17.199738 duration_in_ms=13102.574
2017-12-17 02:14:17,205 [salt.state       ][INFO    ][8770] Running state [qemu-utils] at time 02:14:17.204794
2017-12-17 02:14:17,205 [salt.state       ][INFO    ][8770] Executing state pkg.installed for qemu-utils
2017-12-17 02:14:17,393 [salt.state       ][INFO    ][8770] Package qemu-utils is already installed
2017-12-17 02:14:17,393 [salt.state       ][INFO    ][8770] Completed state [qemu-utils] at time 02:14:17.393388 duration_in_ms=188.593
2017-12-17 02:14:17,394 [salt.state       ][INFO    ][8770] Running state [qemu-kvm] at time 02:14:17.393572
2017-12-17 02:14:17,394 [salt.state       ][INFO    ][8770] Executing state pkg.installed for qemu-kvm
2017-12-17 02:14:17,396 [salt.state       ][INFO    ][8770] Package qemu-kvm is already installed
2017-12-17 02:14:17,396 [salt.state       ][INFO    ][8770] Completed state [qemu-kvm] at time 02:14:17.396367 duration_in_ms=2.796
2017-12-17 02:14:17,397 [salt.state       ][INFO    ][8770] Running state [/etc/libvirt/libvirtd.conf] at time 02:14:17.397376
2017-12-17 02:14:17,398 [salt.state       ][INFO    ][8770] Executing state file.managed for /etc/libvirt/libvirtd.conf
2017-12-17 02:14:17,423 [salt.fileclient  ][INFO    ][8770] Fetching file from saltenv 'base', ** done ** 'libvirt/files/libvirtd.conf.Debian'
2017-12-17 02:14:17,434 [salt.state       ][INFO    ][8770] 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-17 02:14:17,435 [salt.state       ][INFO    ][8770] Completed state [/etc/libvirt/libvirtd.conf] at time 02:14:17.434534 duration_in_ms=37.158
2017-12-17 02:14:17,435 [salt.state       ][INFO    ][8770] Running state [/etc/default/libvirt-bin] at time 02:14:17.434888
2017-12-17 02:14:17,435 [salt.state       ][INFO    ][8770] Executing state file.managed for /etc/default/libvirt-bin
2017-12-17 02:14:17,453 [salt.fileclient  ][INFO    ][8770] Fetching file from saltenv 'base', ** done ** 'libvirt/files/libvirt-bin'
2017-12-17 02:14:17,457 [salt.state       ][INFO    ][8770] File changed:
New file
2017-12-17 02:14:17,457 [salt.state       ][INFO    ][8770] Completed state [/etc/default/libvirt-bin] at time 02:14:17.457057 duration_in_ms=22.169
2017-12-17 02:14:17,458 [salt.state       ][INFO    ][8770] Running state [service.systemctl_reload] at time 02:14:17.457799
2017-12-17 02:14:17,458 [salt.state       ][INFO    ][8770] Executing state module.wait for service.systemctl_reload
2017-12-17 02:14:17,458 [salt.state       ][INFO    ][8770] No changes made for service.systemctl_reload
2017-12-17 02:14:17,458 [salt.state       ][INFO    ][8770] Completed state [service.systemctl_reload] at time 02:14:17.458289 duration_in_ms=0.49
2017-12-17 02:14:17,458 [salt.state       ][INFO    ][8770] Running state [service.systemctl_reload] at time 02:14:17.458418
2017-12-17 02:14:17,459 [salt.state       ][INFO    ][8770] Executing state module.mod_watch for service.systemctl_reload
2017-12-17 02:14:17,459 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-17 02:14:17,498 [salt.state       ][INFO    ][8770] {'ret': True}
2017-12-17 02:14:17,499 [salt.state       ][INFO    ][8770] Completed state [service.systemctl_reload] at time 02:14:17.498473 duration_in_ms=40.055
2017-12-17 02:14:17,500 [salt.state       ][INFO    ][8770] Running state [/etc/libvirt/qemu/networks/default.xml] at time 02:14:17.499855
2017-12-17 02:14:17,500 [salt.state       ][INFO    ][8770] Executing state file.absent for /etc/libvirt/qemu/networks/default.xml
2017-12-17 02:14:17,500 [salt.state       ][INFO    ][8770] {'removed': '/etc/libvirt/qemu/networks/default.xml'}
2017-12-17 02:14:17,500 [salt.state       ][INFO    ][8770] Completed state [/etc/libvirt/qemu/networks/default.xml] at time 02:14:17.500457 duration_in_ms=0.602
2017-12-17 02:14:17,501 [salt.state       ][INFO    ][8770] Running state [libvirtd] at time 02:14:17.500794
2017-12-17 02:14:17,501 [salt.state       ][INFO    ][8770] Executing state service.running for libvirtd
2017-12-17 02:14:17,501 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command ['systemctl', 'status', 'libvirtd.service', '-n', '0'] in directory '/root'
2017-12-17 02:14:17,510 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command ['systemctl', 'is-active', 'libvirtd.service'] in directory '/root'
2017-12-17 02:14:17,517 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command ['systemctl', 'is-enabled', 'libvirtd.service'] in directory '/root'
2017-12-17 02:14:17,524 [salt.state       ][INFO    ][8770] The service libvirtd is already running
2017-12-17 02:14:17,524 [salt.state       ][INFO    ][8770] Completed state [libvirtd] at time 02:14:17.524203 duration_in_ms=23.409
2017-12-17 02:14:17,524 [salt.state       ][INFO    ][8770] Running state [libvirtd] at time 02:14:17.524363
2017-12-17 02:14:17,525 [salt.state       ][INFO    ][8770] Executing state service.mod_watch for libvirtd
2017-12-17 02:14:17,525 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command ['systemctl', 'is-active', 'libvirtd.service'] in directory '/root'
2017-12-17 02:14:17,532 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command ['systemctl', 'is-enabled', 'libvirtd.service'] in directory '/root'
2017-12-17 02:14:17,539 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'libvirtd.service'] in directory '/root'
2017-12-17 02:14:17,585 [salt.state       ][INFO    ][8770] {'libvirtd': True}
2017-12-17 02:14:17,585 [salt.state       ][INFO    ][8770] Completed state [libvirtd] at time 02:14:17.584955 duration_in_ms=60.592
2017-12-17 02:14:17,586 [salt.state       ][INFO    ][8770] Running state [virsh net-undefine default;virsh net-destroy default 2>&1 1>/dev/null] at time 02:14:17.586015
2017-12-17 02:14:17,586 [salt.state       ][INFO    ][8770] Executing state cmd.run for virsh net-undefine default;virsh net-destroy default 2>&1 1>/dev/null
2017-12-17 02:14:17,587 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command 'virsh -q net-list --all | grep -Eq '^\s*default'' in directory '/root'
2017-12-17 02:14:17,820 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command 'virsh net-undefine default;virsh net-destroy default 2>&1 1>/dev/null' in directory '/root'
2017-12-17 02:14:18,228 [salt.state       ][INFO    ][8770] {'pid': 12933, 'retcode': 0, 'stderr': "error: Failed to undefine network default\nerror: Requested operation is not valid: can't undefine transient network", 'stdout': ''}
2017-12-17 02:14:18,229 [salt.state       ][INFO    ][8770] Completed state [virsh net-undefine default;virsh net-destroy default 2>&1 1>/dev/null] at time 02:14:18.228713 duration_in_ms=642.696
2017-12-17 02:14:18,229 [salt.state       ][INFO    ][8770] Running state [virsh net-autostart default --disable] at time 02:14:18.229013
2017-12-17 02:14:18,229 [salt.state       ][INFO    ][8770] Executing state cmd.run for virsh net-autostart default --disable
2017-12-17 02:14:18,230 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command 'virsh net-info default | grep -Eq '^Autostart:\s+yes'' in directory '/root'
2017-12-17 02:14:18,251 [salt.state       ][INFO    ][8770] onlyif execution failed
2017-12-17 02:14:18,252 [salt.state       ][INFO    ][8770] Completed state [virsh net-autostart default --disable] at time 02:14:18.251667 duration_in_ms=22.654
2017-12-17 02:14:18,252 [salt.state       ][INFO    ][8770] Running state [virsh net-destroy default] at time 02:14:18.251935
2017-12-17 02:14:18,252 [salt.state       ][INFO    ][8770] Executing state cmd.run for virsh net-destroy default
2017-12-17 02:14:18,253 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command 'virsh -q net-list --all | grep -Eq '^\s*default\s+active'' in directory '/root'
2017-12-17 02:14:18,273 [salt.state       ][INFO    ][8770] onlyif execution failed
2017-12-17 02:14:18,273 [salt.state       ][INFO    ][8770] Completed state [virsh net-destroy default] at time 02:14:18.272774 duration_in_ms=20.839
2017-12-17 02:14:18,273 [salt.state       ][INFO    ][8770] Running state [echo 'No pool is defined'] at time 02:14:18.273023
2017-12-17 02:14:18,273 [salt.state       ][INFO    ][8770] Executing state cmd.run for echo 'No pool is defined'
2017-12-17 02:14:18,274 [salt.loaded.int.module.cmdmod][INFO    ][8770] Executing command 'echo 'No pool is defined'' in directory '/root'
2017-12-17 02:14:18,281 [salt.state       ][INFO    ][8770] {'pid': 12972, 'retcode': 0, 'stderr': '', 'stdout': 'No pool is defined'}
2017-12-17 02:14:18,281 [salt.state       ][INFO    ][8770] Completed state [echo 'No pool is defined'] at time 02:14:18.281431 duration_in_ms=8.407
2017-12-17 02:14:18,283 [salt.minion      ][INFO    ][8770] Returning information for job: 20171217021315212113
2017-12-17 02:14:25,009 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command state.apply with jid 20171217021425003314
2017-12-17 02:14:25,024 [salt.minion      ][INFO    ][12977] Starting a new job with PID 12977
2017-12-17 02:14:27,501 [salt.state       ][INFO    ][12977] Loading fresh modules for state activity
2017-12-17 02:14:27,521 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/init.sls'
2017-12-17 02:14:27,539 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-17 02:14:27,549 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-17 02:14:27,571 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-17 02:14:27,627 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-17 02:14:27,641 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-17 02:14:27,681 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-17 02:14:27,700 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-17 02:14:27,710 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-17 02:14:27,723 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-17 02:14:27,730 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-17 02:14:27,741 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-17 02:14:27,760 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-17 02:14:27,774 [py.warnings      ][WARNING ][12977] /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-17 02:14:27,774 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'salt-minion --version' in directory '/root'
2017-12-17 02:14:28,072 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'salt-minion --version' in directory '/root'
2017-12-17 02:14:28,395 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-17 02:14:28,414 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-17 02:14:28,426 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-17 02:14:28,439 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-17 02:14:28,474 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-17 02:14:28,489 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-17 02:14:28,514 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-17 02:14:28,527 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-17 02:14:28,543 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-17 02:14:28,574 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-17 02:14:28,631 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-17 02:14:28,652 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-17 02:14:28,710 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-17 02:14:28,731 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-17 02:14:28,774 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-17 02:14:28,796 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-17 02:14:28,808 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-17 02:14:28,823 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-17 02:14:28,829 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-17 02:14:28,840 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-17 02:14:28,859 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-17 02:14:28,874 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'salt-minion --version' in directory '/root'
2017-12-17 02:14:29,180 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'salt-minion --version' in directory '/root'
2017-12-17 02:14:29,503 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-17 02:14:29,521 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-17 02:14:29,536 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-17 02:14:29,549 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-17 02:14:29,584 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-17 02:14:29,605 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-17 02:14:29,627 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-17 02:14:29,639 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-17 02:14:29,655 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-17 02:14:29,691 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-17 02:14:29,751 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-17 02:14:29,810 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-17 02:14:29,861 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-17 02:14:29,877 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-17 02:14:29,901 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-17 02:14:30,212 [salt.state       ][INFO    ][12977] Running state [salt-minion] at time 02:14:30.212254
2017-12-17 02:14:30,213 [salt.state       ][INFO    ][12977] Executing state pkg.installed for salt-minion
2017-12-17 02:14:30,213 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:14:30,502 [salt.state       ][INFO    ][12977] Package salt-minion is already installed
2017-12-17 02:14:30,502 [salt.state       ][INFO    ][12977] Completed state [salt-minion] at time 02:14:30.501861 duration_in_ms=289.608
2017-12-17 02:14:30,502 [salt.state       ][INFO    ][12977] Running state [salt_minion_dependency_packages] at time 02:14:30.502089
2017-12-17 02:14:30,502 [salt.state       ][INFO    ][12977] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-17 02:14:30,505 [salt.state       ][INFO    ][12977] All specified packages are already installed
2017-12-17 02:14:30,505 [salt.state       ][INFO    ][12977] Completed state [salt_minion_dependency_packages] at time 02:14:30.505064 duration_in_ms=2.975
2017-12-17 02:14:30,507 [salt.state       ][INFO    ][12977] Running state [/etc/salt/minion.d/minion.conf] at time 02:14:30.506582
2017-12-17 02:14:30,507 [salt.state       ][INFO    ][12977] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-17 02:14:30,530 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-17 02:14:30,573 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-17 02:14:30,663 [salt.fileclient  ][INFO    ][12977] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-17 02:14:30,696 [salt.state       ][INFO    ][12977] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-17 02:14:30,697 [salt.state       ][INFO    ][12977] Completed state [/etc/salt/minion.d/minion.conf] at time 02:14:30.696601 duration_in_ms=190.019
2017-12-17 02:14:30,697 [salt.state       ][INFO    ][12977] Running state [/etc/salt/minion.d/_virt.conf] at time 02:14:30.696899
2017-12-17 02:14:30,697 [salt.state       ][INFO    ][12977] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-17 02:14:30,703 [salt.state       ][INFO    ][12977] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-17 02:14:30,703 [salt.state       ][INFO    ][12977] Completed state [/etc/salt/minion.d/_virt.conf] at time 02:14:30.702780 duration_in_ms=5.882
2017-12-17 02:14:30,704 [salt.state       ][INFO    ][12977] Running state [salt-minion] at time 02:14:30.704146
2017-12-17 02:14:30,704 [salt.state       ][INFO    ][12977] Executing state service.running for salt-minion
2017-12-17 02:14:30,705 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-17 02:14:30,721 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-17 02:14:30,729 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-17 02:14:30,737 [salt.state       ][INFO    ][12977] The service salt-minion is already running
2017-12-17 02:14:30,737 [salt.state       ][INFO    ][12977] Completed state [salt-minion] at time 02:14:30.736772 duration_in_ms=32.625
2017-12-17 02:14:30,738 [salt.state       ][INFO    ][12977] Running state [/etc/salt/grains.d] at time 02:14:30.738276
2017-12-17 02:14:30,739 [salt.state       ][INFO    ][12977] Executing state file.directory for /etc/salt/grains.d
2017-12-17 02:14:30,739 [salt.state       ][INFO    ][12977] Directory /etc/salt/grains.d is in the correct state
2017-12-17 02:14:30,739 [salt.state       ][INFO    ][12977] Completed state [/etc/salt/grains.d] at time 02:14:30.739163 duration_in_ms=0.888
2017-12-17 02:14:30,740 [salt.state       ][INFO    ][12977] Running state [/etc/salt/grains] at time 02:14:30.739591
2017-12-17 02:14:30,740 [salt.state       ][INFO    ][12977] Executing state file.managed for /etc/salt/grains
2017-12-17 02:14:30,740 [salt.state       ][INFO    ][12977] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-17 02:14:30,740 [salt.state       ][INFO    ][12977] Completed state [/etc/salt/grains] at time 02:14:30.740224 duration_in_ms=0.633
2017-12-17 02:14:30,741 [salt.state       ][INFO    ][12977] Running state [/etc/salt/grains.d/placeholder] at time 02:14:30.740501
2017-12-17 02:14:30,741 [salt.state       ][INFO    ][12977] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-17 02:14:30,741 [salt.state       ][INFO    ][12977] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-17 02:14:30,741 [salt.state       ][INFO    ][12977] Completed state [/etc/salt/grains.d/placeholder] at time 02:14:30.741131 duration_in_ms=0.629
2017-12-17 02:14:30,741 [salt.state       ][INFO    ][12977] Running state [/etc/salt/grains.d/sphinx] at time 02:14:30.741422
2017-12-17 02:14:30,742 [salt.state       ][INFO    ][12977] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-17 02:14:30,745 [salt.state       ][INFO    ][12977] File changed:
--- 
+++ 
@@ -49,6 +49,7 @@
               - 10.167.4.143
               - 127.0.0.1
               - 192.168.11.251
+              - 192.168.122.1
         system:
           name: System
           param:

2017-12-17 02:14:30,745 [salt.state       ][INFO    ][12977] Completed state [/etc/salt/grains.d/sphinx] at time 02:14:30.744986 duration_in_ms=3.563
2017-12-17 02:14:30,746 [salt.state       ][INFO    ][12977] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:14:30.745606
2017-12-17 02:14:30,746 [salt.state       ][INFO    ][12977] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-17 02:14:30,746 [salt.state       ][INFO    ][12977] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-17 02:14:30,746 [salt.state       ][INFO    ][12977] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:14:30.746099 duration_in_ms=0.494
2017-12-17 02:14:30,746 [salt.state       ][INFO    ][12977] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:14:30.746235
2017-12-17 02:14:30,746 [salt.state       ][INFO    ][12977] 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-17 02:14:30,747 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-12-17 02:14:30,828 [salt.state       ][INFO    ][12977] {'pid': 13047, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-17 02:14:30,828 [salt.state       ][INFO    ][12977] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:14:30.828053 duration_in_ms=81.818
2017-12-17 02:14:30,829 [salt.state       ][INFO    ][12977] Running state [/etc/salt/grains.d/dns_records] at time 02:14:30.828537
2017-12-17 02:14:30,829 [salt.state       ][INFO    ][12977] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-17 02:14:30,835 [salt.state       ][INFO    ][12977] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-17 02:14:30,835 [salt.state       ][INFO    ][12977] Completed state [/etc/salt/grains.d/dns_records] at time 02:14:30.834794 duration_in_ms=6.257
2017-12-17 02:14:30,836 [salt.state       ][INFO    ][12977] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 02:14:30.835531
2017-12-17 02:14:30,836 [salt.state       ][INFO    ][12977] 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-17 02:14:30,836 [salt.state       ][INFO    ][12977] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-17 02:14:30,836 [salt.state       ][INFO    ][12977] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 02:14:30.836186 duration_in_ms=0.655
2017-12-17 02:14:30,837 [salt.state       ][INFO    ][12977] Running state [/etc/salt/grains.d/salt] at time 02:14:30.836527
2017-12-17 02:14:30,837 [salt.state       ][INFO    ][12977] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-17 02:14:30,841 [salt.state       ][INFO    ][12977] File /etc/salt/grains.d/salt is in the correct state
2017-12-17 02:14:30,841 [salt.state       ][INFO    ][12977] Completed state [/etc/salt/grains.d/salt] at time 02:14:30.840924 duration_in_ms=4.397
2017-12-17 02:14:30,842 [salt.state       ][INFO    ][12977] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 02:14:30.841839
2017-12-17 02:14:30,842 [salt.state       ][INFO    ][12977] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-17 02:14:30,842 [salt.state       ][INFO    ][12977] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-17 02:14:30,843 [salt.state       ][INFO    ][12977] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 02:14:30.842512 duration_in_ms=0.674
2017-12-17 02:14:30,844 [salt.state       ][INFO    ][12977] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:14:30.843673
2017-12-17 02:14:30,844 [salt.state       ][INFO    ][12977] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-17 02:14:30,844 [salt.state       ][INFO    ][12977] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-17 02:14:30,844 [salt.state       ][INFO    ][12977] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:14:30.844127 duration_in_ms=0.454
2017-12-17 02:14:30,844 [salt.state       ][INFO    ][12977] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:14:30.844252
2017-12-17 02:14:30,844 [salt.state       ][INFO    ][12977] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-17 02:14:30,846 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-12-17 02:14:30,854 [salt.state       ][INFO    ][12977] {'pid': 13049, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-17 02:14:30,854 [salt.state       ][INFO    ][12977] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:14:30.853977 duration_in_ms=9.725
2017-12-17 02:14:30,855 [salt.state       ][INFO    ][12977] Running state [mine.update] at time 02:14:30.854604
2017-12-17 02:14:30,855 [salt.state       ][INFO    ][12977] Executing state module.wait for mine.update
2017-12-17 02:14:30,855 [salt.state       ][INFO    ][12977] No changes made for mine.update
2017-12-17 02:14:30,855 [salt.state       ][INFO    ][12977] Completed state [mine.update] at time 02:14:30.855264 duration_in_ms=0.661
2017-12-17 02:14:30,855 [salt.state       ][INFO    ][12977] Running state [mine.update] at time 02:14:30.855438
2017-12-17 02:14:30,856 [salt.state       ][INFO    ][12977] Executing state module.mod_watch for mine.update
2017-12-17 02:14:31,376 [salt.state       ][INFO    ][12977] {'ret': True}
2017-12-17 02:14:31,376 [salt.state       ][INFO    ][12977] Completed state [mine.update] at time 02:14:31.376076 duration_in_ms=520.637
2017-12-17 02:14:31,376 [salt.state       ][INFO    ][12977] Running state [ca-certificates] at time 02:14:31.376329
2017-12-17 02:14:31,377 [salt.state       ][INFO    ][12977] Executing state pkg.installed for ca-certificates
2017-12-17 02:14:31,380 [salt.state       ][INFO    ][12977] Package ca-certificates is already installed
2017-12-17 02:14:31,380 [salt.state       ][INFO    ][12977] Completed state [ca-certificates] at time 02:14:31.380087 duration_in_ms=3.758
2017-12-17 02:14:31,381 [salt.state       ][INFO    ][12977] Running state [update-ca-certificates] at time 02:14:31.380641
2017-12-17 02:14:31,381 [salt.state       ][INFO    ][12977] Executing state cmd.wait for update-ca-certificates
2017-12-17 02:14:31,381 [salt.state       ][INFO    ][12977] No changes made for update-ca-certificates
2017-12-17 02:14:31,381 [salt.state       ][INFO    ][12977] Completed state [update-ca-certificates] at time 02:14:31.381275 duration_in_ms=0.634
2017-12-17 02:14:31,381 [salt.state       ][INFO    ][12977] Running state [libvirt-dev] at time 02:14:31.381467
2017-12-17 02:14:31,382 [salt.state       ][INFO    ][12977] Executing state pkg.installed for libvirt-dev
2017-12-17 02:14:31,390 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-17 02:14:33,304 [salt.loaded.int.module.cmdmod][INFO    ][12977] 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-17 02:14:35,068 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021435060651
2017-12-17 02:14:35,085 [salt.minion      ][INFO    ][13412] Starting a new job with PID 13412
2017-12-17 02:14:35,129 [salt.minion      ][INFO    ][13412] Returning information for job: 20171217021435060651
2017-12-17 02:14:45,086 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021445078527
2017-12-17 02:14:45,100 [salt.minion      ][INFO    ][13529] Starting a new job with PID 13529
2017-12-17 02:14:45,153 [salt.minion      ][INFO    ][13529] Returning information for job: 20171217021445078527
2017-12-17 02:14:55,105 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021455097365
2017-12-17 02:14:55,120 [salt.minion      ][INFO    ][13734] Starting a new job with PID 13734
2017-12-17 02:14:55,178 [salt.minion      ][INFO    ][13734] Returning information for job: 20171217021455097365
2017-12-17 02:15:05,130 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021505122472
2017-12-17 02:15:05,146 [salt.minion      ][INFO    ][18535] Starting a new job with PID 18535
2017-12-17 02:15:05,192 [salt.minion      ][INFO    ][18535] Returning information for job: 20171217021505122472
2017-12-17 02:15:06,750 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:15:06,824 [salt.state       ][INFO    ][12977] 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-17 02:15:06,832 [salt.state       ][INFO    ][12977] Loading fresh modules for state activity
2017-12-17 02:15:06,846 [salt.state       ][INFO    ][12977] Completed state [libvirt-dev] at time 02:15:06.845569 duration_in_ms=35464.102
2017-12-17 02:15:06,853 [salt.state       ][INFO    ][12977] Running state [pkg-config] at time 02:15:06.852887
2017-12-17 02:15:06,853 [salt.state       ][INFO    ][12977] Executing state pkg.installed for pkg-config
2017-12-17 02:15:07,047 [salt.state       ][INFO    ][12977] Package pkg-config is already installed
2017-12-17 02:15:07,047 [salt.state       ][INFO    ][12977] Completed state [pkg-config] at time 02:15:07.047172 duration_in_ms=194.285
2017-12-17 02:15:07,048 [salt.state       ][INFO    ][12977] Running state [virtng.init] at time 02:15:07.047532
2017-12-17 02:15:07,048 [salt.state       ][INFO    ][12977] Executing state module.run for virtng.init
2017-12-17 02:15:07,081 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command ['git', '--version'] in directory '/root'
2017-12-17 02:15:07,122 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:15:15,147 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021515139520
2017-12-17 02:15:15,160 [salt.minion      ][INFO    ][18614] Starting a new job with PID 18614
2017-12-17 02:15:15,170 [salt.minion      ][INFO    ][18614] Returning information for job: 20171217021515139520
2017-12-17 02:15:25,369 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021525362349
2017-12-17 02:15:25,382 [salt.minion      ][INFO    ][18629] Starting a new job with PID 18629
2017-12-17 02:15:25,390 [salt.minion      ][INFO    ][18629] Returning information for job: 20171217021525362349
2017-12-17 02:15:35,567 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021535559651
2017-12-17 02:15:35,580 [salt.minion      ][INFO    ][18634] Starting a new job with PID 18634
2017-12-17 02:15:35,590 [salt.minion      ][INFO    ][18634] Returning information for job: 20171217021535559651
2017-12-17 02:15:41,837 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-17 02:15:41,863 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-17 02:15:41,916 [salt.loaded.int.module.cmdmod][ERROR   ][12977] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-17 02:15:41,917 [salt.loaded.int.module.cmdmod][ERROR   ][12977] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-17 02:15:41,917 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/mdb03.baremetal-mcp-pike-ovs-ha.local/system.qcow2' in directory '/root'
2017-12-17 02:15:41,928 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-17 02:15:41,935 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-17 02:15:43,003 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-17 02:15:43,583 [salt.loaded.ext.module.seedng][INFO    ][12977] salt-minion pre-installed on image, configuring as mdb03.baremetal-mcp-pike-ovs-ha.local
2017-12-17 02:15:43,617 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'mount -l' in directory '/root'
2017-12-17 02:15:43,631 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-17 02:15:44,252 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-17 02:15:44,797 [salt.state       ][INFO    ][12977] {'ret': True}
2017-12-17 02:15:44,797 [salt.state       ][INFO    ][12977] Completed state [virtng.init] at time 02:15:44.797182 duration_in_ms=37749.649
2017-12-17 02:15:44,797 [salt.state       ][INFO    ][12977] Running state [virt.set_autostart] at time 02:15:44.797430
2017-12-17 02:15:44,798 [salt.state       ][INFO    ][12977] Executing state module.run for virt.set_autostart
2017-12-17 02:15:44,800 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:15:44,817 [salt.state       ][INFO    ][12977] {'ret': True}
2017-12-17 02:15:44,817 [salt.state       ][INFO    ][12977] Completed state [virt.set_autostart] at time 02:15:44.817452 duration_in_ms=20.022
2017-12-17 02:15:44,818 [salt.state       ][INFO    ][12977] Running state [virtng.init] at time 02:15:44.817658
2017-12-17 02:15:44,818 [salt.state       ][INFO    ][12977] Executing state module.run for virtng.init
2017-12-17 02:15:44,820 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:15:45,597 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021545590869
2017-12-17 02:15:45,609 [salt.minion      ][INFO    ][19041] Starting a new job with PID 19041
2017-12-17 02:15:45,618 [salt.minion      ][INFO    ][19041] Returning information for job: 20171217021545590869
2017-12-17 02:15:46,671 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-17 02:15:46,677 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-17 02:15:46,683 [salt.loaded.int.module.cmdmod][ERROR   ][12977] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-17 02:15:46,683 [salt.loaded.int.module.cmdmod][ERROR   ][12977] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-17 02:15:46,684 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/dbs03.baremetal-mcp-pike-ovs-ha.local/system.qcow2' in directory '/root'
2017-12-17 02:15:46,692 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-17 02:15:46,698 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-17 02:15:47,745 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-17 02:15:48,252 [salt.loaded.ext.module.seedng][INFO    ][12977] salt-minion pre-installed on image, configuring as dbs03.baremetal-mcp-pike-ovs-ha.local
2017-12-17 02:15:48,284 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'mount -l' in directory '/root'
2017-12-17 02:15:48,302 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-17 02:15:50,894 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-17 02:15:51,365 [salt.state       ][INFO    ][12977] {'ret': True}
2017-12-17 02:15:51,366 [salt.state       ][INFO    ][12977] Completed state [virtng.init] at time 02:15:51.365676 duration_in_ms=6548.018
2017-12-17 02:15:51,366 [salt.state       ][INFO    ][12977] Running state [virt.set_autostart] at time 02:15:51.365890
2017-12-17 02:15:51,366 [salt.state       ][INFO    ][12977] Executing state module.run for virt.set_autostart
2017-12-17 02:15:51,368 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:15:51,386 [salt.state       ][INFO    ][12977] {'ret': True}
2017-12-17 02:15:51,386 [salt.state       ][INFO    ][12977] Completed state [virt.set_autostart] at time 02:15:51.386395 duration_in_ms=20.505
2017-12-17 02:15:51,387 [salt.state       ][INFO    ][12977] Running state [virtng.init] at time 02:15:51.386581
2017-12-17 02:15:51,387 [salt.state       ][INFO    ][12977] Executing state module.run for virtng.init
2017-12-17 02:15:51,389 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:15:53,946 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-17 02:15:53,954 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-17 02:15:53,961 [salt.loaded.int.module.cmdmod][ERROR   ][12977] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-17 02:15:53,961 [salt.loaded.int.module.cmdmod][ERROR   ][12977] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-17 02:15:53,961 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/prx02.baremetal-mcp-pike-ovs-ha.local/system.qcow2' in directory '/root'
2017-12-17 02:15:53,971 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-17 02:15:53,977 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-17 02:15:55,030 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-17 02:15:55,500 [salt.loaded.ext.module.seedng][INFO    ][12977] salt-minion pre-installed on image, configuring as prx02.baremetal-mcp-pike-ovs-ha.local
2017-12-17 02:15:55,526 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'mount -l' in directory '/root'
2017-12-17 02:15:55,535 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-17 02:15:55,795 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021555789181
2017-12-17 02:15:55,805 [salt.minion      ][INFO    ][19357] Starting a new job with PID 19357
2017-12-17 02:15:55,821 [salt.minion      ][INFO    ][19357] Returning information for job: 20171217021555789181
2017-12-17 02:15:57,284 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-17 02:15:58,102 [salt.state       ][INFO    ][12977] {'ret': True}
2017-12-17 02:15:58,102 [salt.state       ][INFO    ][12977] Completed state [virtng.init] at time 02:15:58.101890 duration_in_ms=6715.309
2017-12-17 02:15:58,102 [salt.state       ][INFO    ][12977] Running state [virt.set_autostart] at time 02:15:58.102256
2017-12-17 02:15:58,103 [salt.state       ][INFO    ][12977] Executing state module.run for virt.set_autostart
2017-12-17 02:15:58,106 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:15:58,125 [salt.state       ][INFO    ][12977] {'ret': True}
2017-12-17 02:15:58,125 [salt.state       ][INFO    ][12977] Completed state [virt.set_autostart] at time 02:15:58.124763 duration_in_ms=22.507
2017-12-17 02:15:58,125 [salt.state       ][INFO    ][12977] Running state [virtng.init] at time 02:15:58.124950
2017-12-17 02:15:58,125 [salt.state       ][INFO    ][12977] Executing state module.run for virtng.init
2017-12-17 02:15:58,127 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:00,466 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-17 02:16:00,472 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-17 02:16:00,477 [salt.loaded.int.module.cmdmod][ERROR   ][12977] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-17 02:16:00,478 [salt.loaded.int.module.cmdmod][ERROR   ][12977] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-17 02:16:00,478 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/msg03.baremetal-mcp-pike-ovs-ha.local/system.qcow2' in directory '/root'
2017-12-17 02:16:00,486 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-17 02:16:00,493 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-17 02:16:01,530 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-17 02:16:02,129 [salt.loaded.ext.module.seedng][INFO    ][12977] salt-minion pre-installed on image, configuring as msg03.baremetal-mcp-pike-ovs-ha.local
2017-12-17 02:16:02,154 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'mount -l' in directory '/root'
2017-12-17 02:16:02,170 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-17 02:16:05,747 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-17 02:16:05,992 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217021605985607
2017-12-17 02:16:06,002 [salt.minion      ][INFO    ][19841] Starting a new job with PID 19841
2017-12-17 02:16:06,011 [salt.minion      ][INFO    ][19841] Returning information for job: 20171217021605985607
2017-12-17 02:16:06,351 [salt.state       ][INFO    ][12977] {'ret': True}
2017-12-17 02:16:06,351 [salt.state       ][INFO    ][12977] Completed state [virtng.init] at time 02:16:06.351304 duration_in_ms=8226.354
2017-12-17 02:16:06,352 [salt.state       ][INFO    ][12977] Running state [virt.set_autostart] at time 02:16:06.351599
2017-12-17 02:16:06,352 [salt.state       ][INFO    ][12977] Executing state module.run for virt.set_autostart
2017-12-17 02:16:06,354 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:06,374 [salt.state       ][INFO    ][12977] {'ret': True}
2017-12-17 02:16:06,374 [salt.state       ][INFO    ][12977] Completed state [virt.set_autostart] at time 02:16:06.373771 duration_in_ms=22.171
2017-12-17 02:16:06,374 [salt.state       ][INFO    ][12977] Running state [virtng.init] at time 02:16:06.373998
2017-12-17 02:16:06,374 [salt.state       ][INFO    ][12977] Executing state module.run for virtng.init
2017-12-17 02:16:06,376 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:08,627 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-12-17 02:16:08,635 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-17 02:16:08,640 [salt.loaded.int.module.cmdmod][ERROR   ][12977] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-17 02:16:08,641 [salt.loaded.int.module.cmdmod][ERROR   ][12977] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-17 02:16:08,641 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/ctl03.baremetal-mcp-pike-ovs-ha.local/system.qcow2' in directory '/root'
2017-12-17 02:16:08,650 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-12-17 02:16:08,657 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-12-17 02:16:09,718 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-12-17 02:16:10,222 [salt.loaded.ext.module.seedng][INFO    ][12977] salt-minion pre-installed on image, configuring as ctl03.baremetal-mcp-pike-ovs-ha.local
2017-12-17 02:16:10,307 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'mount -l' in directory '/root'
2017-12-17 02:16:10,413 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-12-17 02:16:12,720 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-12-17 02:16:13,294 [salt.state       ][INFO    ][12977] {'ret': True}
2017-12-17 02:16:13,294 [salt.state       ][INFO    ][12977] Completed state [virtng.init] at time 02:16:13.294243 duration_in_ms=6920.245
2017-12-17 02:16:13,294 [salt.state       ][INFO    ][12977] Running state [virt.set_autostart] at time 02:16:13.294454
2017-12-17 02:16:13,295 [salt.state       ][INFO    ][12977] Executing state module.run for virt.set_autostart
2017-12-17 02:16:13,297 [salt.loaded.int.module.cmdmod][INFO    ][12977] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:13,314 [salt.state       ][INFO    ][12977] {'ret': True}
2017-12-17 02:16:13,315 [salt.state       ][INFO    ][12977] Completed state [virt.set_autostart] at time 02:16:13.314593 duration_in_ms=20.138
2017-12-17 02:16:13,317 [salt.minion      ][INFO    ][12977] Returning information for job: 20171217021425003314
2017-12-17 02:16:37,129 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command state.sls with jid 20171217021637126871
2017-12-17 02:16:37,143 [salt.minion      ][INFO    ][20240] Starting a new job with PID 20240
2017-12-17 02:16:39,624 [salt.state       ][INFO    ][20240] Loading fresh modules for state activity
2017-12-17 02:16:39,649 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-17 02:16:39,669 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-17 02:16:39,696 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-17 02:16:39,767 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-17 02:16:39,782 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-17 02:16:39,807 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-17 02:16:39,864 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-17 02:16:39,883 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-17 02:16:39,985 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-17 02:16:40,009 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-17 02:16:40,021 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-17 02:16:40,039 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-17 02:16:40,046 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-17 02:16:40,057 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-17 02:16:40,077 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-17 02:16:40,091 [py.warnings      ][WARNING ][20240] /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-17 02:16:40,092 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'salt-minion --version' in directory '/root'
2017-12-17 02:16:40,415 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'salt-minion --version' in directory '/root'
2017-12-17 02:16:40,753 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-17 02:16:40,774 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-17 02:16:40,786 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-17 02:16:40,799 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-17 02:16:40,835 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-17 02:16:40,849 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-17 02:16:40,870 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-17 02:16:40,941 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-17 02:16:40,958 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-17 02:16:40,996 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-17 02:16:41,053 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-17 02:16:41,076 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-17 02:16:41,181 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-17 02:16:41,203 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-17 02:16:41,251 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-17 02:16:41,323 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-17 02:16:41,361 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-17 02:16:41,379 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-17 02:16:41,386 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-17 02:16:41,422 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-17 02:16:41,445 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-17 02:16:41,461 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'salt-minion --version' in directory '/root'
2017-12-17 02:16:41,802 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'salt-minion --version' in directory '/root'
2017-12-17 02:16:42,119 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-17 02:16:42,139 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-17 02:16:42,150 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-17 02:16:42,163 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-17 02:16:42,240 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-17 02:16:42,254 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-17 02:16:42,275 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-17 02:16:42,287 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-17 02:16:42,303 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-17 02:16:42,333 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-17 02:16:42,397 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-17 02:16:42,480 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-17 02:16:42,786 [salt.state       ][INFO    ][20240] Running state [salt-minion] at time 02:16:42.785605
2017-12-17 02:16:42,786 [salt.state       ][INFO    ][20240] Executing state pkg.installed for salt-minion
2017-12-17 02:16:42,786 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:16:43,041 [salt.state       ][INFO    ][20240] Package salt-minion is already installed
2017-12-17 02:16:43,041 [salt.state       ][INFO    ][20240] Completed state [salt-minion] at time 02:16:43.041362 duration_in_ms=255.756
2017-12-17 02:16:43,042 [salt.state       ][INFO    ][20240] Running state [salt_minion_dependency_packages] at time 02:16:43.041601
2017-12-17 02:16:43,042 [salt.state       ][INFO    ][20240] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-17 02:16:43,044 [salt.state       ][INFO    ][20240] All specified packages are already installed
2017-12-17 02:16:43,045 [salt.state       ][INFO    ][20240] Completed state [salt_minion_dependency_packages] at time 02:16:43.044602 duration_in_ms=3.001
2017-12-17 02:16:43,046 [salt.state       ][INFO    ][20240] Running state [/etc/salt/minion.d/minion.conf] at time 02:16:43.046144
2017-12-17 02:16:43,046 [salt.state       ][INFO    ][20240] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-17 02:16:43,069 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-17 02:16:43,119 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-17 02:16:43,223 [salt.fileclient  ][INFO    ][20240] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-17 02:16:43,258 [salt.state       ][INFO    ][20240] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-17 02:16:43,258 [salt.state       ][INFO    ][20240] Completed state [/etc/salt/minion.d/minion.conf] at time 02:16:43.258003 duration_in_ms=211.859
2017-12-17 02:16:43,258 [salt.state       ][INFO    ][20240] Running state [/etc/salt/minion.d/_virt.conf] at time 02:16:43.258330
2017-12-17 02:16:43,259 [salt.state       ][INFO    ][20240] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-17 02:16:43,283 [salt.state       ][INFO    ][20240] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-17 02:16:43,283 [salt.state       ][INFO    ][20240] Completed state [/etc/salt/minion.d/_virt.conf] at time 02:16:43.282766 duration_in_ms=24.436
2017-12-17 02:16:43,284 [salt.state       ][INFO    ][20240] Running state [salt-minion] at time 02:16:43.284387
2017-12-17 02:16:43,285 [salt.state       ][INFO    ][20240] Executing state service.running for salt-minion
2017-12-17 02:16:43,285 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-17 02:16:43,298 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-17 02:16:43,305 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-17 02:16:43,310 [salt.state       ][INFO    ][20240] The service salt-minion is already running
2017-12-17 02:16:43,311 [salt.state       ][INFO    ][20240] Completed state [salt-minion] at time 02:16:43.310628 duration_in_ms=26.24
2017-12-17 02:16:43,312 [salt.state       ][INFO    ][20240] Running state [/etc/salt/grains.d] at time 02:16:43.311890
2017-12-17 02:16:43,312 [salt.state       ][INFO    ][20240] Executing state file.directory for /etc/salt/grains.d
2017-12-17 02:16:43,313 [salt.state       ][INFO    ][20240] Directory /etc/salt/grains.d is in the correct state
2017-12-17 02:16:43,313 [salt.state       ][INFO    ][20240] Completed state [/etc/salt/grains.d] at time 02:16:43.312674 duration_in_ms=0.785
2017-12-17 02:16:43,313 [salt.state       ][INFO    ][20240] Running state [/etc/salt/grains] at time 02:16:43.313075
2017-12-17 02:16:43,313 [salt.state       ][INFO    ][20240] Executing state file.managed for /etc/salt/grains
2017-12-17 02:16:43,314 [salt.state       ][INFO    ][20240] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-17 02:16:43,314 [salt.state       ][INFO    ][20240] Completed state [/etc/salt/grains] at time 02:16:43.313665 duration_in_ms=0.591
2017-12-17 02:16:43,314 [salt.state       ][INFO    ][20240] Running state [/etc/salt/grains.d/placeholder] at time 02:16:43.313933
2017-12-17 02:16:43,314 [salt.state       ][INFO    ][20240] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-17 02:16:43,314 [salt.state       ][INFO    ][20240] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-17 02:16:43,315 [salt.state       ][INFO    ][20240] Completed state [/etc/salt/grains.d/placeholder] at time 02:16:43.314500 duration_in_ms=0.566
2017-12-17 02:16:43,315 [salt.state       ][INFO    ][20240] Running state [/etc/salt/grains.d/sphinx] at time 02:16:43.314776
2017-12-17 02:16:43,315 [salt.state       ][INFO    ][20240] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-17 02:16:43,496 [salt.state       ][INFO    ][20240] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.143
               - 127.0.0.1
               - 192.168.11.251
-              - 192.168.122.1
         system:
           name: System
           param:

2017-12-17 02:16:43,496 [salt.state       ][INFO    ][20240] Completed state [/etc/salt/grains.d/sphinx] at time 02:16:43.496037 duration_in_ms=181.26
2017-12-17 02:16:43,497 [salt.state       ][INFO    ][20240] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:16:43.496741
2017-12-17 02:16:43,497 [salt.state       ][INFO    ][20240] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-17 02:16:43,497 [salt.state       ][INFO    ][20240] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-17 02:16:43,497 [salt.state       ][INFO    ][20240] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:16:43.497279 duration_in_ms=0.539
2017-12-17 02:16:43,497 [salt.state       ][INFO    ][20240] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:16:43.497417
2017-12-17 02:16:43,498 [salt.state       ][INFO    ][20240] 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-17 02:16:43,498 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-12-17 02:16:43,576 [salt.state       ][INFO    ][20240] {'pid': 20312, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-17 02:16:43,576 [salt.state       ][INFO    ][20240] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:16:43.576457 duration_in_ms=79.04
2017-12-17 02:16:43,577 [salt.state       ][INFO    ][20240] Running state [/etc/salt/grains.d/dns_records] at time 02:16:43.576887
2017-12-17 02:16:43,577 [salt.state       ][INFO    ][20240] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-17 02:16:43,783 [salt.state       ][INFO    ][20240] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-17 02:16:43,784 [salt.state       ][INFO    ][20240] Completed state [/etc/salt/grains.d/dns_records] at time 02:16:43.783723 duration_in_ms=206.836
2017-12-17 02:16:43,785 [salt.state       ][INFO    ][20240] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 02:16:43.784518
2017-12-17 02:16:43,785 [salt.state       ][INFO    ][20240] 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-17 02:16:43,785 [salt.state       ][INFO    ][20240] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-17 02:16:43,785 [salt.state       ][INFO    ][20240] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 02:16:43.785108 duration_in_ms=0.59
2017-12-17 02:16:43,785 [salt.state       ][INFO    ][20240] Running state [/etc/salt/grains.d/salt] at time 02:16:43.785406
2017-12-17 02:16:43,786 [salt.state       ][INFO    ][20240] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-17 02:16:43,848 [salt.state       ][INFO    ][20240] File /etc/salt/grains.d/salt is in the correct state
2017-12-17 02:16:43,848 [salt.state       ][INFO    ][20240] Completed state [/etc/salt/grains.d/salt] at time 02:16:43.847793 duration_in_ms=62.388
2017-12-17 02:16:43,848 [salt.state       ][INFO    ][20240] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 02:16:43.848424
2017-12-17 02:16:43,849 [salt.state       ][INFO    ][20240] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-17 02:16:43,849 [salt.state       ][INFO    ][20240] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-17 02:16:43,849 [salt.state       ][INFO    ][20240] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 02:16:43.848980 duration_in_ms=0.556
2017-12-17 02:16:43,851 [salt.state       ][INFO    ][20240] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:16:43.851181
2017-12-17 02:16:43,852 [salt.state       ][INFO    ][20240] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-17 02:16:43,852 [salt.state       ][INFO    ][20240] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-17 02:16:43,852 [salt.state       ][INFO    ][20240] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:16:43.852429 duration_in_ms=1.249
2017-12-17 02:16:43,853 [salt.state       ][INFO    ][20240] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:16:43.852670
2017-12-17 02:16:43,853 [salt.state       ][INFO    ][20240] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-17 02:16:43,854 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-12-17 02:16:43,863 [salt.state       ][INFO    ][20240] {'pid': 20314, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-17 02:16:43,864 [salt.state       ][INFO    ][20240] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:16:43.863710 duration_in_ms=11.04
2017-12-17 02:16:43,864 [salt.state       ][INFO    ][20240] Running state [mine.update] at time 02:16:43.864396
2017-12-17 02:16:43,865 [salt.state       ][INFO    ][20240] Executing state module.wait for mine.update
2017-12-17 02:16:43,865 [salt.state       ][INFO    ][20240] No changes made for mine.update
2017-12-17 02:16:43,865 [salt.state       ][INFO    ][20240] Completed state [mine.update] at time 02:16:43.865083 duration_in_ms=0.687
2017-12-17 02:16:43,865 [salt.state       ][INFO    ][20240] Running state [mine.update] at time 02:16:43.865262
2017-12-17 02:16:43,865 [salt.state       ][INFO    ][20240] Executing state module.mod_watch for mine.update
2017-12-17 02:16:44,386 [salt.state       ][INFO    ][20240] {'ret': True}
2017-12-17 02:16:44,386 [salt.state       ][INFO    ][20240] Completed state [mine.update] at time 02:16:44.385912 duration_in_ms=520.649
2017-12-17 02:16:44,386 [salt.state       ][INFO    ][20240] Running state [ca-certificates] at time 02:16:44.386155
2017-12-17 02:16:44,386 [salt.state       ][INFO    ][20240] Executing state pkg.installed for ca-certificates
2017-12-17 02:16:44,390 [salt.state       ][INFO    ][20240] Package ca-certificates is already installed
2017-12-17 02:16:44,390 [salt.state       ][INFO    ][20240] Completed state [ca-certificates] at time 02:16:44.389670 duration_in_ms=3.514
2017-12-17 02:16:44,390 [salt.state       ][INFO    ][20240] Running state [update-ca-certificates] at time 02:16:44.390217
2017-12-17 02:16:44,390 [salt.state       ][INFO    ][20240] Executing state cmd.wait for update-ca-certificates
2017-12-17 02:16:44,391 [salt.state       ][INFO    ][20240] No changes made for update-ca-certificates
2017-12-17 02:16:44,391 [salt.state       ][INFO    ][20240] Completed state [update-ca-certificates] at time 02:16:44.390744 duration_in_ms=0.527
2017-12-17 02:16:44,391 [salt.state       ][INFO    ][20240] Running state [libvirt-dev] at time 02:16:44.390904
2017-12-17 02:16:44,391 [salt.state       ][INFO    ][20240] Executing state pkg.installed for libvirt-dev
2017-12-17 02:16:44,394 [salt.state       ][INFO    ][20240] Package libvirt-dev is already installed
2017-12-17 02:16:44,394 [salt.state       ][INFO    ][20240] Completed state [libvirt-dev] at time 02:16:44.393829 duration_in_ms=2.926
2017-12-17 02:16:44,394 [salt.state       ][INFO    ][20240] Running state [pkg-config] at time 02:16:44.394003
2017-12-17 02:16:44,394 [salt.state       ][INFO    ][20240] Executing state pkg.installed for pkg-config
2017-12-17 02:16:44,397 [salt.state       ][INFO    ][20240] Package pkg-config is already installed
2017-12-17 02:16:44,397 [salt.state       ][INFO    ][20240] Completed state [pkg-config] at time 02:16:44.396898 duration_in_ms=2.896
2017-12-17 02:16:44,397 [salt.state       ][INFO    ][20240] Running state [virtng.init] at time 02:16:44.397056
2017-12-17 02:16:44,397 [salt.state       ][INFO    ][20240] Executing state module.run for virtng.init
2017-12-17 02:16:44,434 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command ['git', '--version'] in directory '/root'
2017-12-17 02:16:44,628 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:44,645 [salt.state       ][INFO    ][20240] unless execution succeeded
2017-12-17 02:16:44,645 [salt.state       ][INFO    ][20240] Completed state [virtng.init] at time 02:16:44.645416 duration_in_ms=248.36
2017-12-17 02:16:44,646 [salt.state       ][INFO    ][20240] Running state [virt.set_autostart] at time 02:16:44.645681
2017-12-17 02:16:44,646 [salt.state       ][INFO    ][20240] Executing state module.run for virt.set_autostart
2017-12-17 02:16:44,649 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:44,665 [salt.state       ][INFO    ][20240] unless execution succeeded
2017-12-17 02:16:44,665 [salt.state       ][INFO    ][20240] Completed state [virt.set_autostart] at time 02:16:44.665349 duration_in_ms=19.667
2017-12-17 02:16:44,666 [salt.state       ][INFO    ][20240] Running state [virtng.init] at time 02:16:44.665581
2017-12-17 02:16:44,666 [salt.state       ][INFO    ][20240] Executing state module.run for virtng.init
2017-12-17 02:16:44,668 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:44,682 [salt.state       ][INFO    ][20240] unless execution succeeded
2017-12-17 02:16:44,801 [salt.state       ][INFO    ][20240] Completed state [virtng.init] at time 02:16:44.800678 duration_in_ms=135.095
2017-12-17 02:16:44,801 [salt.state       ][INFO    ][20240] Running state [virt.set_autostart] at time 02:16:44.801079
2017-12-17 02:16:44,801 [salt.state       ][INFO    ][20240] Executing state module.run for virt.set_autostart
2017-12-17 02:16:44,803 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:44,821 [salt.state       ][INFO    ][20240] unless execution succeeded
2017-12-17 02:16:44,822 [salt.state       ][INFO    ][20240] Completed state [virt.set_autostart] at time 02:16:44.821614 duration_in_ms=20.535
2017-12-17 02:16:44,822 [salt.state       ][INFO    ][20240] Running state [virtng.init] at time 02:16:44.821863
2017-12-17 02:16:44,822 [salt.state       ][INFO    ][20240] Executing state module.run for virtng.init
2017-12-17 02:16:44,824 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:44,841 [salt.state       ][INFO    ][20240] unless execution succeeded
2017-12-17 02:16:44,910 [salt.state       ][INFO    ][20240] Completed state [virtng.init] at time 02:16:44.909777 duration_in_ms=87.913
2017-12-17 02:16:44,910 [salt.state       ][INFO    ][20240] Running state [virt.set_autostart] at time 02:16:44.910152
2017-12-17 02:16:44,910 [salt.state       ][INFO    ][20240] Executing state module.run for virt.set_autostart
2017-12-17 02:16:44,913 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:44,931 [salt.state       ][INFO    ][20240] unless execution succeeded
2017-12-17 02:16:44,931 [salt.state       ][INFO    ][20240] Completed state [virt.set_autostart] at time 02:16:44.930788 duration_in_ms=20.636
2017-12-17 02:16:44,931 [salt.state       ][INFO    ][20240] Running state [virtng.init] at time 02:16:44.931061
2017-12-17 02:16:44,931 [salt.state       ][INFO    ][20240] Executing state module.run for virtng.init
2017-12-17 02:16:44,933 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:44,949 [salt.state       ][INFO    ][20240] unless execution succeeded
2017-12-17 02:16:44,949 [salt.state       ][INFO    ][20240] Completed state [virtng.init] at time 02:16:44.949016 duration_in_ms=17.954
2017-12-17 02:16:44,949 [salt.state       ][INFO    ][20240] Running state [virt.set_autostart] at time 02:16:44.949271
2017-12-17 02:16:44,950 [salt.state       ][INFO    ][20240] Executing state module.run for virt.set_autostart
2017-12-17 02:16:44,952 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:45,033 [salt.state       ][INFO    ][20240] unless execution succeeded
2017-12-17 02:16:45,033 [salt.state       ][INFO    ][20240] Completed state [virt.set_autostart] at time 02:16:45.032881 duration_in_ms=83.609
2017-12-17 02:16:45,033 [salt.state       ][INFO    ][20240] Running state [virtng.init] at time 02:16:45.033153
2017-12-17 02:16:45,033 [salt.state       ][INFO    ][20240] Executing state module.run for virtng.init
2017-12-17 02:16:45,035 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:45,051 [salt.state       ][INFO    ][20240] unless execution succeeded
2017-12-17 02:16:45,051 [salt.state       ][INFO    ][20240] Completed state [virtng.init] at time 02:16:45.050832 duration_in_ms=17.677
2017-12-17 02:16:45,051 [salt.state       ][INFO    ][20240] Running state [virt.set_autostart] at time 02:16:45.051094
2017-12-17 02:16:45,051 [salt.state       ][INFO    ][20240] Executing state module.run for virt.set_autostart
2017-12-17 02:16:45,053 [salt.loaded.int.module.cmdmod][INFO    ][20240] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-pike-ovs-ha.local$"' in directory '/root'
2017-12-17 02:16:45,068 [salt.state       ][INFO    ][20240] unless execution succeeded
2017-12-17 02:16:45,069 [salt.state       ][INFO    ][20240] Completed state [virt.set_autostart] at time 02:16:45.068673 duration_in_ms=17.579
2017-12-17 02:16:45,071 [salt.minion      ][INFO    ][20240] Returning information for job: 20171217021637126871
2017-12-17 02:18:07,986 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171217021807985717
2017-12-17 02:18:08,003 [salt.minion      ][INFO    ][20395] Starting a new job with PID 20395
2017-12-17 02:18:11,430 [salt.state       ][INFO    ][20395] Loading fresh modules for state activity
2017-12-17 02:18:11,449 [salt.state       ][ERROR   ][20395] No contents found in top file
2017-12-17 02:18:11,450 [salt.utils.extmods][INFO    ][20395] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-17 02:18:11,453 [salt.utils.extmods][INFO    ][20395] Syncing beacons for environment 'base'
2017-12-17 02:18:11,453 [salt.utils.extmods][INFO    ][20395] Loading cache from salt://_beacons, for base)
2017-12-17 02:18:11,453 [salt.fileclient  ][INFO    ][20395] Caching directory '_beacons/' for environment 'base'
2017-12-17 02:18:11,476 [salt.utils.extmods][INFO    ][20395] Syncing modules for environment 'base'
2017-12-17 02:18:11,476 [salt.utils.extmods][INFO    ][20395] Loading cache from salt://_modules, for base)
2017-12-17 02:18:11,476 [salt.fileclient  ][INFO    ][20395] Caching directory '_modules/' for environment 'base'
2017-12-17 02:18:11,546 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-17 02:18:11,562 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-17 02:18:11,576 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-17 02:18:11,597 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-17 02:18:11,608 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-17 02:18:11,619 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-17 02:18:11,628 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-17 02:18:11,649 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-17 02:18:11,660 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-17 02:18:11,818 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-17 02:18:11,856 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-17 02:18:11,894 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-17 02:18:11,912 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-17 02:18:11,938 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-17 02:18:11,964 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-17 02:18:12,011 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-17 02:18:12,033 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-17 02:18:12,076 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-17 02:18:12,120 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/modelschema.py'
2017-12-17 02:18:12,159 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-17 02:18:12,190 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-17 02:18:12,199 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-17 02:18:12,219 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-17 02:18:12,269 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-17 02:18:12,300 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-17 02:18:12,311 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-17 02:18:12,326 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-17 02:18:12,343 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-17 02:18:12,366 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-17 02:18:12,388 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-17 02:18:12,418 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-17 02:18:12,467 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-17 02:18:12,486 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-17 02:18:12,507 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-17 02:18:12,548 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-17 02:18:12,551 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-17 02:18:12,551 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-17 02:18:12,551 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-17 02:18:12,552 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-17 02:18:12,552 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-17 02:18:12,553 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-17 02:18:12,553 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-17 02:18:12,554 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-17 02:18:12,554 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-17 02:18:12,555 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-17 02:18:12,555 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-17 02:18:12,556 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-17 02:18:12,556 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-17 02:18:12,560 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-17 02:18:12,560 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-17 02:18:12,563 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-17 02:18:12,564 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-17 02:18:12,569 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-17 02:18:12,573 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-17 02:18:12,580 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/modelschema.py' to '/var/cache/salt/minion/extmods/modules/modelschema.py'
2017-12-17 02:18:12,581 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-17 02:18:12,581 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-17 02:18:12,588 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-17 02:18:12,588 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-17 02:18:12,589 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-17 02:18:12,591 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-17 02:18:12,592 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-17 02:18:12,592 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-17 02:18:12,598 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-17 02:18:12,603 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-17 02:18:12,608 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-17 02:18:12,610 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-17 02:18:12,611 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-17 02:18:12,611 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-17 02:18:12,611 [salt.utils.extmods][INFO    ][20395] 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-17 02:18:12,612 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-17 02:18:12,612 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-17 02:18:12,617 [salt.utils.extmods][INFO    ][20395] Syncing states for environment 'base'
2017-12-17 02:18:12,617 [salt.utils.extmods][INFO    ][20395] Loading cache from salt://_states, for base)
2017-12-17 02:18:12,617 [salt.fileclient  ][INFO    ][20395] Caching directory '_states/' for environment 'base'
2017-12-17 02:18:12,662 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-17 02:18:12,671 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-17 02:18:12,696 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-17 02:18:12,741 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-17 02:18:12,761 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-17 02:18:12,788 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-17 02:18:12,802 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-17 02:18:12,855 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-17 02:18:12,878 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-17 02:18:12,897 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-17 02:18:12,906 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-17 02:18:12,977 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-17 02:18:13,101 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-17 02:18:13,193 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-17 02:18:13,312 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-17 02:18:13,336 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-17 02:18:13,409 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-17 02:18:13,449 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-17 02:18:13,467 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-17 02:18:13,474 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-17 02:18:13,484 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-17 02:18:13,527 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-17 02:18:13,540 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-17 02:18:13,551 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-17 02:18:13,565 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-17 02:18:13,572 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-17 02:18:13,630 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-17 02:18:13,654 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-17 02:18:13,663 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-17 02:18:13,671 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-17 02:18:13,693 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-17 02:18:13,714 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-17 02:18:13,717 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-17 02:18:13,717 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-17 02:18:13,717 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-17 02:18:13,718 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-17 02:18:13,718 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-17 02:18:13,718 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-17 02:18:13,718 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-17 02:18:13,719 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-17 02:18:13,719 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-17 02:18:13,719 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-17 02:18:13,719 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-17 02:18:13,719 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-17 02:18:13,719 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-17 02:18:13,720 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-17 02:18:13,720 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-17 02:18:13,720 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-17 02:18:13,720 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-17 02:18:13,720 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-17 02:18:13,721 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-17 02:18:13,721 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-17 02:18:13,721 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-17 02:18:13,721 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-17 02:18:13,721 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-17 02:18:13,722 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-17 02:18:13,722 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-17 02:18:13,722 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-17 02:18:13,722 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-17 02:18:13,722 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-17 02:18:13,723 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-17 02:18:13,723 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-17 02:18:13,723 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-17 02:18:13,723 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-17 02:18:13,723 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-17 02:18:13,725 [salt.utils.extmods][INFO    ][20395] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-17 02:18:13,728 [salt.utils.extmods][INFO    ][20395] Syncing sdb for environment 'base'
2017-12-17 02:18:13,728 [salt.utils.extmods][INFO    ][20395] Loading cache from salt://_sdb, for base)
2017-12-17 02:18:13,728 [salt.fileclient  ][INFO    ][20395] Caching directory '_sdb/' for environment 'base'
2017-12-17 02:18:13,765 [salt.utils.extmods][INFO    ][20395] Syncing grains for environment 'base'
2017-12-17 02:18:13,766 [salt.utils.extmods][INFO    ][20395] Loading cache from salt://_grains, for base)
2017-12-17 02:18:13,766 [salt.fileclient  ][INFO    ][20395] Caching directory '_grains/' for environment 'base'
2017-12-17 02:18:13,808 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-17 02:18:13,841 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-17 02:18:13,867 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-17 02:18:13,879 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-17 02:18:13,913 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-17 02:18:13,933 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-17 02:18:13,957 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-17 02:18:13,968 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-17 02:18:13,976 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-17 02:18:13,985 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-17 02:18:13,992 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-17 02:18:14,014 [salt.fileclient  ][INFO    ][20395] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-17 02:18:14,017 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-17 02:18:14,017 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-17 02:18:14,018 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-17 02:18:14,018 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-17 02:18:14,019 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-17 02:18:14,019 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-17 02:18:14,020 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-17 02:18:14,021 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-17 02:18:14,021 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-17 02:18:14,021 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-17 02:18:14,022 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-17 02:18:14,022 [salt.utils.extmods][INFO    ][20395] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-17 02:18:14,023 [salt.utils.extmods][INFO    ][20395] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-17 02:18:14,025 [salt.utils.extmods][INFO    ][20395] Syncing renderers for environment 'base'
2017-12-17 02:18:14,026 [salt.utils.extmods][INFO    ][20395] Loading cache from salt://_renderers, for base)
2017-12-17 02:18:14,026 [salt.fileclient  ][INFO    ][20395] Caching directory '_renderers/' for environment 'base'
2017-12-17 02:18:14,074 [salt.utils.extmods][INFO    ][20395] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-17 02:18:14,077 [salt.utils.extmods][INFO    ][20395] Syncing returners for environment 'base'
2017-12-17 02:18:14,077 [salt.utils.extmods][INFO    ][20395] Loading cache from salt://_returners, for base)
2017-12-17 02:18:14,077 [salt.fileclient  ][INFO    ][20395] Caching directory '_returners/' for environment 'base'
2017-12-17 02:18:14,102 [salt.utils.extmods][INFO    ][20395] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-17 02:18:14,104 [salt.utils.extmods][INFO    ][20395] Syncing output for environment 'base'
2017-12-17 02:18:14,104 [salt.utils.extmods][INFO    ][20395] Loading cache from salt://_output, for base)
2017-12-17 02:18:14,104 [salt.fileclient  ][INFO    ][20395] Caching directory '_output/' for environment 'base'
2017-12-17 02:18:14,137 [salt.utils.extmods][INFO    ][20395] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-17 02:18:14,139 [salt.utils.extmods][INFO    ][20395] Syncing utils for environment 'base'
2017-12-17 02:18:14,140 [salt.utils.extmods][INFO    ][20395] Loading cache from salt://_utils, for base)
2017-12-17 02:18:14,140 [salt.fileclient  ][INFO    ][20395] Caching directory '_utils/' for environment 'base'
2017-12-17 02:18:14,163 [salt.utils.extmods][INFO    ][20395] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-17 02:18:14,166 [salt.utils.extmods][INFO    ][20395] Syncing log_handlers for environment 'base'
2017-12-17 02:18:14,166 [salt.utils.extmods][INFO    ][20395] Loading cache from salt://_log_handlers, for base)
2017-12-17 02:18:14,166 [salt.fileclient  ][INFO    ][20395] Caching directory '_log_handlers/' for environment 'base'
2017-12-17 02:18:14,190 [salt.utils.extmods][INFO    ][20395] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-17 02:18:14,193 [salt.utils.extmods][INFO    ][20395] Syncing proxy for environment 'base'
2017-12-17 02:18:14,193 [salt.utils.extmods][INFO    ][20395] Loading cache from salt://_proxy, for base)
2017-12-17 02:18:14,193 [salt.fileclient  ][INFO    ][20395] Caching directory '_proxy/' for environment 'base'
2017-12-17 02:18:14,211 [salt.utils.extmods][INFO    ][20395] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-17 02:18:14,213 [salt.utils.extmods][INFO    ][20395] Syncing engines for environment 'base'
2017-12-17 02:18:14,213 [salt.utils.extmods][INFO    ][20395] Loading cache from salt://_engines, for base)
2017-12-17 02:18:14,213 [salt.fileclient  ][INFO    ][20395] Caching directory '_engines/' for environment 'base'
2017-12-17 02:18:14,237 [salt.minion      ][INFO    ][20395] Returning information for job: 20171217021807985717
2017-12-17 02:40:59,879 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command test.ping with jid 20171217024059867111
2017-12-17 02:40:59,896 [salt.minion      ][INFO    ][20629] Starting a new job with PID 20629
2017-12-17 02:40:59,926 [salt.minion      ][INFO    ][20629] Returning information for job: 20171217024059867111
2017-12-17 02:42:24,176 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command state.sls with jid 20171217024224164290
2017-12-17 02:42:24,192 [salt.minion      ][INFO    ][20653] Starting a new job with PID 20653
2017-12-17 02:42:24,634 [salt.state       ][INFO    ][20653] Loading fresh modules for state activity
2017-12-17 02:42:24,662 [salt.fileclient  ][INFO    ][20653] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-17 02:42:24,681 [salt.fileclient  ][INFO    ][20653] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-17 02:42:24,705 [salt.fileclient  ][INFO    ][20653] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-17 02:42:25,007 [salt.state       ][INFO    ][20653] Running state [lsof] at time 02:42:25.007108
2017-12-17 02:42:25,007 [salt.state       ][INFO    ][20653] Executing state pkg.installed for lsof
2017-12-17 02:42:25,008 [salt.loaded.int.module.cmdmod][INFO    ][20653] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:42:25,267 [salt.state       ][INFO    ][20653] Package lsof is already installed
2017-12-17 02:42:25,268 [salt.state       ][INFO    ][20653] Completed state [lsof] at time 02:42:25.267551 duration_in_ms=260.443
2017-12-17 02:42:25,268 [salt.state       ][INFO    ][20653] Running state [keepalived] at time 02:42:25.267746
2017-12-17 02:42:25,268 [salt.state       ][INFO    ][20653] Executing state pkg.installed for keepalived
2017-12-17 02:42:25,282 [salt.loaded.int.module.cmdmod][INFO    ][20653] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-17 02:42:28,316 [salt.loaded.int.module.cmdmod][INFO    ][20653] 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-17 02:42:34,221 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217024234209029
2017-12-17 02:42:34,236 [salt.minion      ][INFO    ][21760] Starting a new job with PID 21760
2017-12-17 02:42:34,250 [salt.minion      ][INFO    ][21760] Returning information for job: 20171217024234209029
2017-12-17 02:42:36,035 [salt.loaded.int.module.cmdmod][INFO    ][20653] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:42:36,059 [salt.state       ][INFO    ][20653] 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-17 02:42:36,067 [salt.state       ][INFO    ][20653] Loading fresh modules for state activity
2017-12-17 02:42:36,079 [salt.state       ][INFO    ][20653] Completed state [keepalived] at time 02:42:36.079102 duration_in_ms=10811.356
2017-12-17 02:42:36,081 [salt.state       ][INFO    ][20653] Running state [/etc/keepalived/keepalived.conf] at time 02:42:36.080883
2017-12-17 02:42:36,081 [salt.state       ][INFO    ][20653] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-17 02:42:36,108 [salt.fileclient  ][INFO    ][20653] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-17 02:42:36,140 [salt.fileclient  ][INFO    ][20653] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-17 02:42:36,146 [salt.state       ][INFO    ][20653] File changed:
New file
2017-12-17 02:42:36,146 [salt.state       ][INFO    ][20653] Completed state [/etc/keepalived/keepalived.conf] at time 02:42:36.145740 duration_in_ms=64.857
2017-12-17 02:42:36,204 [salt.state       ][INFO    ][20653] Running state [keepalived] at time 02:42:36.203783
2017-12-17 02:42:36,204 [salt.state       ][INFO    ][20653] Executing state service.running for keepalived
2017-12-17 02:42:36,205 [salt.loaded.int.module.cmdmod][INFO    ][20653] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-17 02:42:36,214 [salt.loaded.int.module.cmdmod][INFO    ][20653] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-17 02:42:36,220 [salt.loaded.int.module.cmdmod][INFO    ][20653] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-17 02:42:36,226 [salt.loaded.int.module.cmdmod][INFO    ][20653] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-17 02:42:36,233 [salt.loaded.int.module.cmdmod][INFO    ][20653] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-12-17 02:42:36,293 [salt.loaded.int.module.cmdmod][INFO    ][20653] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-17 02:42:36,301 [salt.loaded.int.module.cmdmod][INFO    ][20653] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-17 02:42:36,308 [salt.loaded.int.module.cmdmod][INFO    ][20653] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-17 02:42:36,314 [salt.state       ][INFO    ][20653] {'keepalived': True}
2017-12-17 02:42:36,314 [salt.state       ][INFO    ][20653] Completed state [keepalived] at time 02:42:36.313687 duration_in_ms=109.904
2017-12-17 02:42:36,314 [salt.minion      ][INFO    ][20653] Returning information for job: 20171217024224164290
2017-12-17 02:44:24,128 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command pillar.get with jid 20171217024424116472
2017-12-17 02:44:24,153 [salt.minion      ][INFO    ][22069] Starting a new job with PID 22069
2017-12-17 02:44:24,162 [salt.minion      ][INFO    ][22069] Returning information for job: 20171217024424116472
2017-12-17 02:48:59,929 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command state.sls with jid 20171217024859921936
2017-12-17 02:48:59,944 [salt.minion      ][INFO    ][22140] Starting a new job with PID 22140
2017-12-17 02:49:02,392 [salt.state       ][INFO    ][22140] Loading fresh modules for state activity
2017-12-17 02:49:02,414 [salt.fileclient  ][INFO    ][22140] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-17 02:49:02,434 [salt.fileclient  ][INFO    ][22140] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-17 02:49:02,722 [salt.state       ][INFO    ][22140] Running state [attr] at time 02:49:02.721629
2017-12-17 02:49:02,722 [salt.state       ][INFO    ][22140] Executing state pkg.installed for attr
2017-12-17 02:49:02,722 [salt.loaded.int.module.cmdmod][INFO    ][22140] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:49:03,001 [salt.loaded.int.module.cmdmod][INFO    ][22140] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-17 02:49:04,489 [salt.loaded.int.module.cmdmod][INFO    ][22140] 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-17 02:49:06,900 [salt.loaded.int.module.cmdmod][INFO    ][22140] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:49:06,923 [salt.state       ][INFO    ][22140] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-12-17 02:49:06,931 [salt.state       ][INFO    ][22140] Loading fresh modules for state activity
2017-12-17 02:49:06,943 [salt.state       ][INFO    ][22140] Completed state [attr] at time 02:49:06.943223 duration_in_ms=4221.595
2017-12-17 02:49:06,948 [salt.state       ][INFO    ][22140] Running state [glusterfs-server] at time 02:49:06.947961
2017-12-17 02:49:06,948 [salt.state       ][INFO    ][22140] Executing state pkg.installed for glusterfs-server
2017-12-17 02:49:07,173 [salt.loaded.int.module.cmdmod][INFO    ][22140] 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-17 02:49:10,020 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217024910008375
2017-12-17 02:49:10,034 [salt.minion      ][INFO    ][22915] Starting a new job with PID 22915
2017-12-17 02:49:10,045 [salt.minion      ][INFO    ][22915] Returning information for job: 20171217024910008375
2017-12-17 02:49:20,227 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command saltutil.find_job with jid 20171217024920213700
2017-12-17 02:49:20,241 [salt.minion      ][INFO    ][23868] Starting a new job with PID 23868
2017-12-17 02:49:20,252 [salt.minion      ][INFO    ][23868] Returning information for job: 20171217024920213700
2017-12-17 02:49:25,886 [salt.loaded.int.module.cmdmod][INFO    ][22140] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:49:25,910 [salt.state       ][INFO    ][22140] 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-17 02:49:25,917 [salt.state       ][INFO    ][22140] Loading fresh modules for state activity
2017-12-17 02:49:25,929 [salt.state       ][INFO    ][22140] Completed state [glusterfs-server] at time 02:49:25.929401 duration_in_ms=18981.44
2017-12-17 02:49:25,934 [salt.state       ][INFO    ][22140] Running state [bc] at time 02:49:25.933982
2017-12-17 02:49:25,934 [salt.state       ][INFO    ][22140] Executing state pkg.installed for bc
2017-12-17 02:49:26,136 [salt.loaded.int.module.cmdmod][INFO    ][22140] 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-17 02:49:28,850 [salt.loaded.int.module.cmdmod][INFO    ][22140] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:49:28,875 [salt.state       ][INFO    ][22140] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-12-17 02:49:28,884 [salt.state       ][INFO    ][22140] Loading fresh modules for state activity
2017-12-17 02:49:28,897 [salt.state       ][INFO    ][22140] Completed state [bc] at time 02:49:28.896569 duration_in_ms=2962.587
2017-12-17 02:49:28,957 [salt.state       ][INFO    ][22140] Running state [glusterd] at time 02:49:28.956910
2017-12-17 02:49:28,957 [salt.state       ][INFO    ][22140] Executing state service.running for glusterd
2017-12-17 02:49:28,958 [salt.loaded.int.module.cmdmod][INFO    ][22140] Executing command ['systemctl', 'status', 'glusterd.service', '-n', '0'] in directory '/root'
2017-12-17 02:49:28,968 [salt.loaded.int.module.cmdmod][INFO    ][22140] Executing command ['systemctl', 'is-active', 'glusterd.service'] in directory '/root'
2017-12-17 02:49:28,976 [salt.loaded.int.module.cmdmod][INFO    ][22140] Executing command ['systemctl', 'is-enabled', 'glusterd.service'] in directory '/root'
2017-12-17 02:49:28,984 [salt.state       ][INFO    ][22140] The service glusterd is already running
2017-12-17 02:49:28,984 [salt.state       ][INFO    ][22140] Completed state [glusterd] at time 02:49:28.984084 duration_in_ms=27.174
2017-12-17 02:49:28,986 [salt.state       ][INFO    ][22140] Running state [/etc/systemd/system/glusterd.service.d/override.conf] at time 02:49:28.986096
2017-12-17 02:49:28,986 [salt.state       ][INFO    ][22140] Executing state file.managed for /etc/systemd/system/glusterd.service.d/override.conf
2017-12-17 02:49:28,999 [salt.state       ][INFO    ][22140] File changed:
New file
2017-12-17 02:49:28,999 [salt.state       ][INFO    ][22140] Completed state [/etc/systemd/system/glusterd.service.d/override.conf] at time 02:49:28.998984 duration_in_ms=12.888
2017-12-17 02:49:28,999 [salt.state       ][INFO    ][22140] Running state [/srv/glusterfs/glance] at time 02:49:28.999144
2017-12-17 02:49:28,999 [salt.state       ][INFO    ][22140] Executing state file.directory for /srv/glusterfs/glance
2017-12-17 02:49:29,018 [salt.state       ][INFO    ][22140] {'/srv/glusterfs/glance': 'New Dir'}
2017-12-17 02:49:29,018 [salt.state       ][INFO    ][22140] Completed state [/srv/glusterfs/glance] at time 02:49:29.018191 duration_in_ms=19.046
2017-12-17 02:49:29,018 [salt.state       ][INFO    ][22140] Running state [/srv/glusterfs/keystone-keys] at time 02:49:29.018392
2017-12-17 02:49:29,019 [salt.state       ][INFO    ][22140] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-17 02:49:29,019 [salt.state       ][INFO    ][22140] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-12-17 02:49:29,019 [salt.state       ][INFO    ][22140] Completed state [/srv/glusterfs/keystone-keys] at time 02:49:29.019067 duration_in_ms=0.676
2017-12-17 02:49:29,019 [salt.state       ][INFO    ][22140] Running state [/srv/glusterfs/nova_instances] at time 02:49:29.019210
2017-12-17 02:49:29,019 [salt.state       ][INFO    ][22140] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-17 02:49:29,020 [salt.state       ][INFO    ][22140] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-12-17 02:49:29,020 [salt.state       ][INFO    ][22140] Completed state [/srv/glusterfs/nova_instances] at time 02:49:29.020001 duration_in_ms=0.79
2017-12-17 02:49:29,020 [salt.state       ][INFO    ][22140] Running state [/srv/glusterfs/keystone-credential-keys] at time 02:49:29.020146
2017-12-17 02:49:29,020 [salt.state       ][INFO    ][22140] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-17 02:49:29,021 [salt.state       ][INFO    ][22140] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-12-17 02:49:29,021 [salt.state       ][INFO    ][22140] Completed state [/srv/glusterfs/keystone-credential-keys] at time 02:49:29.020783 duration_in_ms=0.637
2017-12-17 02:49:29,022 [salt.minion      ][INFO    ][22140] Returning information for job: 20171217024859921936
2017-12-17 02:49:37,663 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command test.ping with jid 20171217024937654631
2017-12-17 02:49:37,679 [salt.minion      ][INFO    ][24950] Starting a new job with PID 24950
2017-12-17 02:49:37,708 [salt.minion      ][INFO    ][24950] Returning information for job: 20171217024937654631
2017-12-17 02:50:21,149 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command state.sls with jid 20171217025021136098
2017-12-17 02:50:21,164 [salt.minion      ][INFO    ][25585] Starting a new job with PID 25585
2017-12-17 02:50:21,576 [salt.state       ][INFO    ][25585] Loading fresh modules for state activity
2017-12-17 02:50:21,598 [salt.fileclient  ][INFO    ][25585] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-17 02:50:21,632 [salt.fileclient  ][INFO    ][25585] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-17 02:50:21,702 [salt.fileclient  ][INFO    ][25585] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-17 02:50:21,721 [salt.fileclient  ][INFO    ][25585] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-17 02:50:21,995 [salt.state       ][INFO    ][25585] Running state [attr] at time 02:50:21.994883
2017-12-17 02:50:21,995 [salt.state       ][INFO    ][25585] Executing state pkg.installed for attr
2017-12-17 02:50:21,996 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 02:50:22,259 [salt.state       ][INFO    ][25585] Package attr is already installed
2017-12-17 02:50:22,259 [salt.state       ][INFO    ][25585] Completed state [attr] at time 02:50:22.259314 duration_in_ms=264.432
2017-12-17 02:50:22,260 [salt.state       ][INFO    ][25585] Running state [glusterfs-server] at time 02:50:22.259516
2017-12-17 02:50:22,260 [salt.state       ][INFO    ][25585] Executing state pkg.installed for glusterfs-server
2017-12-17 02:50:22,262 [salt.state       ][INFO    ][25585] Package glusterfs-server is already installed
2017-12-17 02:50:22,262 [salt.state       ][INFO    ][25585] Completed state [glusterfs-server] at time 02:50:22.262386 duration_in_ms=2.871
2017-12-17 02:50:22,263 [salt.state       ][INFO    ][25585] Running state [bc] at time 02:50:22.262530
2017-12-17 02:50:22,263 [salt.state       ][INFO    ][25585] Executing state pkg.installed for bc
2017-12-17 02:50:22,265 [salt.state       ][INFO    ][25585] Package bc is already installed
2017-12-17 02:50:22,265 [salt.state       ][INFO    ][25585] Completed state [bc] at time 02:50:22.265319 duration_in_ms=2.789
2017-12-17 02:50:22,266 [salt.state       ][INFO    ][25585] Running state [glusterd] at time 02:50:22.266145
2017-12-17 02:50:22,266 [salt.state       ][INFO    ][25585] Executing state service.running for glusterd
2017-12-17 02:50:22,267 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command ['systemctl', 'status', 'glusterd.service', '-n', '0'] in directory '/root'
2017-12-17 02:50:22,277 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-17 02:50:22,318 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command ['systemctl', 'status', 'glusterd.service', '-n', '0'] in directory '/root'
2017-12-17 02:50:22,331 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command ['systemctl', 'is-active', 'glusterd.service'] in directory '/root'
2017-12-17 02:50:22,338 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command ['systemctl', 'is-enabled', 'glusterd.service'] in directory '/root'
2017-12-17 02:50:22,345 [salt.state       ][INFO    ][25585] The service glusterd is already running
2017-12-17 02:50:22,345 [salt.state       ][INFO    ][25585] Completed state [glusterd] at time 02:50:22.345053 duration_in_ms=78.908
2017-12-17 02:50:22,347 [salt.state       ][INFO    ][25585] Running state [/etc/systemd/system/glusterd.service.d/override.conf] at time 02:50:22.346625
2017-12-17 02:50:22,347 [salt.state       ][INFO    ][25585] Executing state file.managed for /etc/systemd/system/glusterd.service.d/override.conf
2017-12-17 02:50:22,356 [salt.state       ][INFO    ][25585] File /etc/systemd/system/glusterd.service.d/override.conf is in the correct state
2017-12-17 02:50:22,356 [salt.state       ][INFO    ][25585] Completed state [/etc/systemd/system/glusterd.service.d/override.conf] at time 02:50:22.355844 duration_in_ms=9.219
2017-12-17 02:50:22,356 [salt.state       ][INFO    ][25585] Running state [/srv/glusterfs/glance] at time 02:50:22.356034
2017-12-17 02:50:22,356 [salt.state       ][INFO    ][25585] Executing state file.directory for /srv/glusterfs/glance
2017-12-17 02:50:22,357 [salt.state       ][INFO    ][25585] Directory /srv/glusterfs/glance is in the correct state
2017-12-17 02:50:22,357 [salt.state       ][INFO    ][25585] Completed state [/srv/glusterfs/glance] at time 02:50:22.356735 duration_in_ms=0.702
2017-12-17 02:50:22,357 [salt.state       ][INFO    ][25585] Running state [/srv/glusterfs/keystone-keys] at time 02:50:22.356916
2017-12-17 02:50:22,357 [salt.state       ][INFO    ][25585] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-17 02:50:22,357 [salt.state       ][INFO    ][25585] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-17 02:50:22,358 [salt.state       ][INFO    ][25585] Completed state [/srv/glusterfs/keystone-keys] at time 02:50:22.357614 duration_in_ms=0.698
2017-12-17 02:50:22,358 [salt.state       ][INFO    ][25585] Running state [/srv/glusterfs/nova_instances] at time 02:50:22.357789
2017-12-17 02:50:22,358 [salt.state       ][INFO    ][25585] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-17 02:50:22,358 [salt.state       ][INFO    ][25585] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-17 02:50:22,359 [salt.state       ][INFO    ][25585] Completed state [/srv/glusterfs/nova_instances] at time 02:50:22.358474 duration_in_ms=0.685
2017-12-17 02:50:22,359 [salt.state       ][INFO    ][25585] Running state [/srv/glusterfs/keystone-credential-keys] at time 02:50:22.358647
2017-12-17 02:50:22,359 [salt.state       ][INFO    ][25585] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-17 02:50:22,359 [salt.state       ][INFO    ][25585] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-17 02:50:22,359 [salt.state       ][INFO    ][25585] Completed state [/srv/glusterfs/keystone-credential-keys] at time 02:50:22.359312 duration_in_ms=0.666
2017-12-17 02:50:22,447 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command ['git', '--version'] in directory '/root'
2017-12-17 02:50:22,494 [salt.state       ][INFO    ][25585] Running state [sleep 5] at time 02:50:22.493828
2017-12-17 02:50:22,494 [salt.state       ][INFO    ][25585] Executing state cmd.wait for sleep 5
2017-12-17 02:50:22,494 [salt.state       ][INFO    ][25585] No changes made for sleep 5
2017-12-17 02:50:22,494 [salt.state       ][INFO    ][25585] Completed state [sleep 5] at time 02:50:22.494414 duration_in_ms=0.586
2017-12-17 02:50:22,495 [salt.state       ][INFO    ][25585] Running state [10.167.4.141] at time 02:50:22.494858
2017-12-17 02:50:22,495 [salt.state       ][INFO    ][25585] Executing state glusterfs.peered for 10.167.4.141
2017-12-17 02:50:22,495 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:22,505 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:22,562 [salt.state       ][INFO    ][25585] Host 10.167.4.141 already peered
2017-12-17 02:50:22,562 [salt.state       ][INFO    ][25585] Completed state [10.167.4.141] at time 02:50:22.561937 duration_in_ms=67.078
2017-12-17 02:50:22,564 [salt.state       ][INFO    ][25585] Running state [10.167.4.142] at time 02:50:22.564131
2017-12-17 02:50:22,564 [salt.state       ][INFO    ][25585] Executing state glusterfs.peered for 10.167.4.142
2017-12-17 02:50:22,565 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:22,574 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:22,625 [salt.state       ][INFO    ][25585] Host 10.167.4.142 already peered
2017-12-17 02:50:22,625 [salt.state       ][INFO    ][25585] Completed state [10.167.4.142] at time 02:50:22.625343 duration_in_ms=61.21
2017-12-17 02:50:22,628 [salt.state       ][INFO    ][25585] Running state [10.167.4.143] at time 02:50:22.627572
2017-12-17 02:50:22,628 [salt.state       ][INFO    ][25585] Executing state glusterfs.peered for 10.167.4.143
2017-12-17 02:50:22,628 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:22,638 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:22,695 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:22,705 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:22,759 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:22,768 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:22,824 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:22,833 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:22,886 [salt.state       ][INFO    ][25585] Peering with localhost is not needed
2017-12-17 02:50:22,886 [salt.state       ][INFO    ][25585] Completed state [10.167.4.143] at time 02:50:22.886036 duration_in_ms=258.463
2017-12-17 02:50:22,887 [salt.state       ][INFO    ][25585] Running state [glance] at time 02:50:22.886884
2017-12-17 02:50:22,887 [salt.state       ][INFO    ][25585] Executing state glusterfs.created for glance
2017-12-17 02:50:22,888 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:22,897 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:22,949 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:22,959 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:23,015 [salt.state       ][INFO    ][25585] Volume glance already exists and is started.
2017-12-17 02:50:23,015 [salt.state       ][INFO    ][25585] Completed state [glance] at time 02:50:23.015172 duration_in_ms=128.287
2017-12-17 02:50:23,018 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 02:50:23.018434
2017-12-17 02:50:23,019 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-17 02:50:23,019 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-17 02:50:23,071 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:23,071 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 02:50:23.070752 duration_in_ms=52.318
2017-12-17 02:50:23,071 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 02:50:23.071224
2017-12-17 02:50:23,071 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-17 02:50:23,072 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-17 02:50:23,127 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:23,127 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 02:50:23.126878 duration_in_ms=55.653
2017-12-17 02:50:23,127 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 02:50:23.127335
2017-12-17 02:50:23,128 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-17 02:50:23,128 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-17 02:50:23,180 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:23,181 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 02:50:23.180660 duration_in_ms=53.325
2017-12-17 02:50:23,181 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 02:50:23.181165
2017-12-17 02:50:23,181 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-17 02:50:23,182 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-17 02:50:23,233 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:23,234 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 02:50:23.233582 duration_in_ms=52.417
2017-12-17 02:50:23,234 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 02:50:23.234037
2017-12-17 02:50:23,234 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-17 02:50:23,235 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-17 02:50:23,290 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:23,291 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 02:50:23.290700 duration_in_ms=56.662
2017-12-17 02:50:23,291 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 02:50:23.291162
2017-12-17 02:50:23,291 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-17 02:50:23,292 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-17 02:50:23,342 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:23,343 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 02:50:23.342519 duration_in_ms=51.357
2017-12-17 02:50:23,344 [salt.state       ][INFO    ][25585] Running state [glance] at time 02:50:23.343660
2017-12-17 02:50:23,344 [salt.state       ][INFO    ][25585] Executing state glusterfs.started for glance
2017-12-17 02:50:23,344 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:23,353 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:23,404 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:23,413 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:23,465 [salt.state       ][INFO    ][25585] Volume glance is already started
2017-12-17 02:50:23,465 [salt.state       ][INFO    ][25585] Completed state [glance] at time 02:50:23.464905 duration_in_ms=121.244
2017-12-17 02:50:23,466 [salt.state       ][INFO    ][25585] Running state [keystone-keys] at time 02:50:23.465810
2017-12-17 02:50:23,466 [salt.state       ][INFO    ][25585] Executing state glusterfs.created for keystone-keys
2017-12-17 02:50:23,467 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:23,476 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:23,527 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:23,536 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:23,606 [salt.state       ][INFO    ][25585] Volume keystone-keys already exists and is started.
2017-12-17 02:50:23,606 [salt.state       ][INFO    ][25585] Completed state [keystone-keys] at time 02:50:23.606391 duration_in_ms=140.58
2017-12-17 02:50:23,610 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 02:50:23.609964
2017-12-17 02:50:23,610 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-17 02:50:23,611 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-17 02:50:23,661 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:23,661 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 02:50:23.661360 duration_in_ms=51.395
2017-12-17 02:50:23,662 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 02:50:23.661903
2017-12-17 02:50:23,662 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-17 02:50:23,663 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-17 02:50:23,714 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:23,714 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 02:50:23.714304 duration_in_ms=52.4
2017-12-17 02:50:23,715 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 02:50:23.714822
2017-12-17 02:50:23,715 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-17 02:50:23,715 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-17 02:50:23,768 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:23,768 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 02:50:23.768106 duration_in_ms=53.284
2017-12-17 02:50:23,769 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 02:50:23.768619
2017-12-17 02:50:23,769 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-17 02:50:23,769 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-17 02:50:23,821 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:23,821 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 02:50:23.821347 duration_in_ms=52.728
2017-12-17 02:50:23,822 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 02:50:23.821862
2017-12-17 02:50:23,822 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-17 02:50:23,823 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-17 02:50:23,873 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:23,873 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 02:50:23.872917 duration_in_ms=51.055
2017-12-17 02:50:23,873 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 02:50:23.873424
2017-12-17 02:50:23,874 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-17 02:50:23,874 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-17 02:50:23,927 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:23,927 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 02:50:23.927417 duration_in_ms=53.993
2017-12-17 02:50:23,929 [salt.state       ][INFO    ][25585] Running state [keystone-keys] at time 02:50:23.928570
2017-12-17 02:50:23,929 [salt.state       ][INFO    ][25585] Executing state glusterfs.started for keystone-keys
2017-12-17 02:50:23,929 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:23,937 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:23,987 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:23,996 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:24,067 [salt.state       ][INFO    ][25585] Volume keystone-keys is already started
2017-12-17 02:50:24,068 [salt.state       ][INFO    ][25585] Completed state [keystone-keys] at time 02:50:24.067671 duration_in_ms=139.101
2017-12-17 02:50:24,069 [salt.state       ][INFO    ][25585] Running state [nova_instances] at time 02:50:24.068550
2017-12-17 02:50:24,069 [salt.state       ][INFO    ][25585] Executing state glusterfs.created for nova_instances
2017-12-17 02:50:24,069 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:24,078 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:24,128 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:24,137 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:24,189 [salt.state       ][INFO    ][25585] Volume nova_instances already exists and is started.
2017-12-17 02:50:24,189 [salt.state       ][INFO    ][25585] Completed state [nova_instances] at time 02:50:24.189422 duration_in_ms=120.872
2017-12-17 02:50:24,193 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 02:50:24.192874
2017-12-17 02:50:24,193 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-17 02:50:24,194 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-17 02:50:24,248 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:24,249 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 02:50:24.248490 duration_in_ms=55.616
2017-12-17 02:50:24,249 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 02:50:24.249279
2017-12-17 02:50:24,250 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-17 02:50:24,251 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-17 02:50:24,308 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:24,309 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 02:50:24.308533 duration_in_ms=59.254
2017-12-17 02:50:24,309 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 02:50:24.309048
2017-12-17 02:50:24,309 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-17 02:50:24,310 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-17 02:50:24,364 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:24,365 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 02:50:24.364666 duration_in_ms=55.617
2017-12-17 02:50:24,365 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 02:50:24.365208
2017-12-17 02:50:24,366 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-17 02:50:24,366 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-17 02:50:24,418 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:24,419 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 02:50:24.418484 duration_in_ms=53.275
2017-12-17 02:50:24,419 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 02:50:24.419039
2017-12-17 02:50:24,419 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-17 02:50:24,420 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-17 02:50:24,473 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:24,473 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 02:50:24.473255 duration_in_ms=54.216
2017-12-17 02:50:24,474 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 02:50:24.473788
2017-12-17 02:50:24,474 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-17 02:50:24,474 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-17 02:50:24,526 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:24,526 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 02:50:24.526073 duration_in_ms=52.284
2017-12-17 02:50:24,527 [salt.state       ][INFO    ][25585] Running state [nova_instances] at time 02:50:24.527289
2017-12-17 02:50:24,528 [salt.state       ][INFO    ][25585] Executing state glusterfs.started for nova_instances
2017-12-17 02:50:24,528 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:24,538 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:24,593 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:24,601 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:24,658 [salt.state       ][INFO    ][25585] Volume nova_instances is already started
2017-12-17 02:50:24,658 [salt.state       ][INFO    ][25585] Completed state [nova_instances] at time 02:50:24.658355 duration_in_ms=131.065
2017-12-17 02:50:24,659 [salt.state       ][INFO    ][25585] Running state [keystone-credential-keys] at time 02:50:24.659360
2017-12-17 02:50:24,660 [salt.state       ][INFO    ][25585] Executing state glusterfs.created for keystone-credential-keys
2017-12-17 02:50:24,660 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:24,670 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:24,719 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:24,728 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:24,783 [salt.state       ][INFO    ][25585] Volume keystone-credential-keys already exists and is started.
2017-12-17 02:50:24,784 [salt.state       ][INFO    ][25585] Completed state [keystone-credential-keys] at time 02:50:24.783675 duration_in_ms=124.315
2017-12-17 02:50:24,788 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 02:50:24.787653
2017-12-17 02:50:24,788 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-17 02:50:24,788 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-17 02:50:24,842 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:24,842 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 02:50:24.842072 duration_in_ms=54.419
2017-12-17 02:50:24,843 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 02:50:24.842590
2017-12-17 02:50:24,843 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-17 02:50:24,843 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-17 02:50:24,894 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:24,894 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 02:50:24.894136 duration_in_ms=51.546
2017-12-17 02:50:24,895 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 02:50:24.894610
2017-12-17 02:50:24,895 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-17 02:50:24,895 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-17 02:50:24,949 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:24,949 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 02:50:24.948710 duration_in_ms=54.099
2017-12-17 02:50:24,949 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 02:50:24.949201
2017-12-17 02:50:24,949 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-17 02:50:24,950 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-17 02:50:25,001 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:25,001 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 02:50:25.001191 duration_in_ms=51.989
2017-12-17 02:50:25,002 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 02:50:25.001722
2017-12-17 02:50:25,002 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-17 02:50:25,002 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-17 02:50:25,057 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:25,058 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 02:50:25.057596 duration_in_ms=55.874
2017-12-17 02:50:25,058 [salt.state       ][INFO    ][25585] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 02:50:25.058084
2017-12-17 02:50:25,058 [salt.state       ][INFO    ][25585] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-17 02:50:25,059 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-17 02:50:25,111 [salt.state       ][INFO    ][25585] unless execution succeeded
2017-12-17 02:50:25,111 [salt.state       ][INFO    ][25585] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 02:50:25.110725 duration_in_ms=52.641
2017-12-17 02:50:25,112 [salt.state       ][INFO    ][25585] Running state [keystone-credential-keys] at time 02:50:25.111893
2017-12-17 02:50:25,112 [salt.state       ][INFO    ][25585] Executing state glusterfs.started for keystone-credential-keys
2017-12-17 02:50:25,112 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:25,122 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:25,172 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --version' in directory '/root'
2017-12-17 02:50:25,180 [salt.loaded.int.module.cmdmod][INFO    ][25585] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 02:50:25,235 [salt.state       ][INFO    ][25585] Volume keystone-credential-keys is already started
2017-12-17 02:50:25,235 [salt.state       ][INFO    ][25585] Completed state [keystone-credential-keys] at time 02:50:25.235281 duration_in_ms=123.387
2017-12-17 02:50:25,237 [salt.minion      ][INFO    ][25585] Returning information for job: 20171217025021136098
2017-12-17 02:50:26,418 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command test.ping with jid 20171217025026405027
2017-12-17 02:50:26,433 [salt.minion      ][INFO    ][26180] Starting a new job with PID 26180
2017-12-17 02:50:26,461 [salt.minion      ][INFO    ][26180] Returning information for job: 20171217025026405027
2017-12-17 02:50:27,124 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command cmd.run with jid 20171217025027113240
2017-12-17 02:50:27,140 [salt.minion      ][INFO    ][26185] Starting a new job with PID 26185
2017-12-17 02:50:27,145 [salt.loaded.int.module.cmdmod][INFO    ][26185] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-17 02:50:27,266 [salt.minion      ][INFO    ][26185] Returning information for job: 20171217025027113240
2017-12-17 03:12:44,622 [salt.utils.schedule][INFO    ][7812] Running scheduled job: __mine_interval
2017-12-17 03:51:09,571 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command test.ping with jid 20171217035109562070
2017-12-17 03:51:09,596 [salt.minion      ][INFO    ][27020] Starting a new job with PID 27020
2017-12-17 03:51:09,638 [salt.minion      ][INFO    ][27020] Returning information for job: 20171217035109562070
2017-12-17 03:51:23,203 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command state.sls with jid 20171217035123192874
2017-12-17 03:51:23,218 [salt.minion      ][INFO    ][27037] Starting a new job with PID 27037
2017-12-17 03:51:23,658 [salt.state       ][INFO    ][27037] Loading fresh modules for state activity
2017-12-17 03:51:23,682 [salt.fileclient  ][INFO    ][27037] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-17 03:51:23,699 [salt.fileclient  ][INFO    ][27037] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-17 03:51:23,722 [salt.fileclient  ][INFO    ][27037] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-17 03:51:23,994 [salt.state       ][INFO    ][27037] Running state [lsof] at time 03:51:23.993689
2017-12-17 03:51:23,994 [salt.state       ][INFO    ][27037] Executing state pkg.installed for lsof
2017-12-17 03:51:23,994 [salt.loaded.int.module.cmdmod][INFO    ][27037] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 03:51:24,275 [salt.state       ][INFO    ][27037] Package lsof is already installed
2017-12-17 03:51:24,275 [salt.state       ][INFO    ][27037] Completed state [lsof] at time 03:51:24.275288 duration_in_ms=281.599
2017-12-17 03:51:24,276 [salt.state       ][INFO    ][27037] Running state [keepalived] at time 03:51:24.275483
2017-12-17 03:51:24,276 [salt.state       ][INFO    ][27037] Executing state pkg.installed for keepalived
2017-12-17 03:51:24,278 [salt.state       ][INFO    ][27037] Package keepalived is already installed
2017-12-17 03:51:24,278 [salt.state       ][INFO    ][27037] Completed state [keepalived] at time 03:51:24.278398 duration_in_ms=2.915
2017-12-17 03:51:24,280 [salt.state       ][INFO    ][27037] Running state [/etc/keepalived/keepalived.conf] at time 03:51:24.279715
2017-12-17 03:51:24,280 [salt.state       ][INFO    ][27037] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-17 03:51:24,301 [salt.fileclient  ][INFO    ][27037] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-17 03:51:24,333 [salt.fileclient  ][INFO    ][27037] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-17 03:51:24,337 [salt.state       ][INFO    ][27037] File /etc/keepalived/keepalived.conf is in the correct state
2017-12-17 03:51:24,337 [salt.state       ][INFO    ][27037] Completed state [/etc/keepalived/keepalived.conf] at time 03:51:24.337051 duration_in_ms=57.336
2017-12-17 03:51:24,338 [salt.state       ][INFO    ][27037] Running state [keepalived] at time 03:51:24.337556
2017-12-17 03:51:24,338 [salt.state       ][INFO    ][27037] Executing state service.running for keepalived
2017-12-17 03:51:24,338 [salt.loaded.int.module.cmdmod][INFO    ][27037] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-17 03:51:24,351 [salt.loaded.int.module.cmdmod][INFO    ][27037] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-17 03:51:24,357 [salt.loaded.int.module.cmdmod][INFO    ][27037] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-17 03:51:24,363 [salt.state       ][INFO    ][27037] The service keepalived is already running
2017-12-17 03:51:24,363 [salt.state       ][INFO    ][27037] Completed state [keepalived] at time 03:51:24.363129 duration_in_ms=25.572
2017-12-17 03:51:24,364 [salt.minion      ][INFO    ][27037] Returning information for job: 20171217035123192874
2017-12-17 03:51:42,891 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command pillar.get with jid 20171217035142886204
2017-12-17 03:51:42,914 [salt.minion      ][INFO    ][27063] Starting a new job with PID 27063
2017-12-17 03:51:42,922 [salt.minion      ][INFO    ][27063] Returning information for job: 20171217035142886204
2017-12-17 03:52:19,916 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command state.sls with jid 20171217035219907903
2017-12-17 03:52:19,932 [salt.minion      ][INFO    ][27068] Starting a new job with PID 27068
2017-12-17 03:52:20,354 [salt.state       ][INFO    ][27068] Loading fresh modules for state activity
2017-12-17 03:52:20,406 [salt.fileclient  ][INFO    ][27068] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-17 03:52:20,427 [salt.fileclient  ][INFO    ][27068] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-17 03:52:20,701 [salt.state       ][INFO    ][27068] Running state [attr] at time 03:52:20.700654
2017-12-17 03:52:20,701 [salt.state       ][INFO    ][27068] Executing state pkg.installed for attr
2017-12-17 03:52:20,701 [salt.loaded.int.module.cmdmod][INFO    ][27068] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 03:52:20,944 [salt.state       ][INFO    ][27068] Package attr is already installed
2017-12-17 03:52:20,944 [salt.state       ][INFO    ][27068] Completed state [attr] at time 03:52:20.943901 duration_in_ms=243.248
2017-12-17 03:52:20,944 [salt.state       ][INFO    ][27068] Running state [glusterfs-server] at time 03:52:20.944093
2017-12-17 03:52:20,944 [salt.state       ][INFO    ][27068] Executing state pkg.installed for glusterfs-server
2017-12-17 03:52:20,947 [salt.state       ][INFO    ][27068] Package glusterfs-server is already installed
2017-12-17 03:52:20,947 [salt.state       ][INFO    ][27068] Completed state [glusterfs-server] at time 03:52:20.946977 duration_in_ms=2.883
2017-12-17 03:52:20,947 [salt.state       ][INFO    ][27068] Running state [bc] at time 03:52:20.947120
2017-12-17 03:52:20,947 [salt.state       ][INFO    ][27068] Executing state pkg.installed for bc
2017-12-17 03:52:20,950 [salt.state       ][INFO    ][27068] Package bc is already installed
2017-12-17 03:52:20,950 [salt.state       ][INFO    ][27068] Completed state [bc] at time 03:52:20.949976 duration_in_ms=2.856
2017-12-17 03:52:20,951 [salt.state       ][INFO    ][27068] Running state [glusterd] at time 03:52:20.950623
2017-12-17 03:52:20,951 [salt.state       ][INFO    ][27068] Executing state service.running for glusterd
2017-12-17 03:52:20,951 [salt.loaded.int.module.cmdmod][INFO    ][27068] Executing command ['systemctl', 'status', 'glusterd.service', '-n', '0'] in directory '/root'
2017-12-17 03:52:20,967 [salt.loaded.int.module.cmdmod][INFO    ][27068] Executing command ['systemctl', 'is-active', 'glusterd.service'] in directory '/root'
2017-12-17 03:52:20,975 [salt.loaded.int.module.cmdmod][INFO    ][27068] Executing command ['systemctl', 'is-enabled', 'glusterd.service'] in directory '/root'
2017-12-17 03:52:20,983 [salt.state       ][INFO    ][27068] The service glusterd is already running
2017-12-17 03:52:20,983 [salt.state       ][INFO    ][27068] Completed state [glusterd] at time 03:52:20.983090 duration_in_ms=32.467
2017-12-17 03:52:20,985 [salt.state       ][INFO    ][27068] Running state [/etc/systemd/system/glusterd.service.d/override.conf] at time 03:52:20.984484
2017-12-17 03:52:20,985 [salt.state       ][INFO    ][27068] Executing state file.managed for /etc/systemd/system/glusterd.service.d/override.conf
2017-12-17 03:52:20,992 [salt.state       ][INFO    ][27068] File /etc/systemd/system/glusterd.service.d/override.conf is in the correct state
2017-12-17 03:52:20,992 [salt.state       ][INFO    ][27068] Completed state [/etc/systemd/system/glusterd.service.d/override.conf] at time 03:52:20.991967 duration_in_ms=7.482
2017-12-17 03:52:20,992 [salt.state       ][INFO    ][27068] Running state [/srv/glusterfs/glance] at time 03:52:20.992139
2017-12-17 03:52:20,992 [salt.state       ][INFO    ][27068] Executing state file.directory for /srv/glusterfs/glance
2017-12-17 03:52:20,993 [salt.state       ][INFO    ][27068] Directory /srv/glusterfs/glance is in the correct state
2017-12-17 03:52:20,993 [salt.state       ][INFO    ][27068] Completed state [/srv/glusterfs/glance] at time 03:52:20.992794 duration_in_ms=0.654
2017-12-17 03:52:20,993 [salt.state       ][INFO    ][27068] Running state [/srv/glusterfs/keystone-keys] at time 03:52:20.992951
2017-12-17 03:52:20,993 [salt.state       ][INFO    ][27068] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-17 03:52:20,993 [salt.state       ][INFO    ][27068] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-17 03:52:20,994 [salt.state       ][INFO    ][27068] Completed state [/srv/glusterfs/keystone-keys] at time 03:52:20.993576 duration_in_ms=0.624
2017-12-17 03:52:20,994 [salt.state       ][INFO    ][27068] Running state [/srv/glusterfs/nova_instances] at time 03:52:20.993733
2017-12-17 03:52:20,994 [salt.state       ][INFO    ][27068] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-17 03:52:20,994 [salt.state       ][INFO    ][27068] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-17 03:52:20,994 [salt.state       ][INFO    ][27068] Completed state [/srv/glusterfs/nova_instances] at time 03:52:20.994371 duration_in_ms=0.638
2017-12-17 03:52:20,995 [salt.state       ][INFO    ][27068] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:52:20.994523
2017-12-17 03:52:20,995 [salt.state       ][INFO    ][27068] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-17 03:52:20,995 [salt.state       ][INFO    ][27068] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-17 03:52:20,995 [salt.state       ][INFO    ][27068] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:52:20.995156 duration_in_ms=0.633
2017-12-17 03:52:20,996 [salt.minion      ][INFO    ][27068] Returning information for job: 20171217035219907903
2017-12-17 03:52:22,092 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command test.ping with jid 20171217035222083267
2017-12-17 03:52:22,108 [salt.minion      ][INFO    ][27089] Starting a new job with PID 27089
2017-12-17 03:52:22,136 [salt.minion      ][INFO    ][27089] Returning information for job: 20171217035222083267
2017-12-17 03:52:32,012 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command state.sls with jid 20171217035232001413
2017-12-17 03:52:32,027 [salt.minion      ][INFO    ][27094] Starting a new job with PID 27094
2017-12-17 03:52:32,469 [salt.state       ][INFO    ][27094] Loading fresh modules for state activity
2017-12-17 03:52:32,491 [salt.fileclient  ][INFO    ][27094] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-17 03:52:32,527 [salt.fileclient  ][INFO    ][27094] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-17 03:52:32,598 [salt.fileclient  ][INFO    ][27094] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-17 03:52:32,617 [salt.fileclient  ][INFO    ][27094] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-17 03:52:32,896 [salt.state       ][INFO    ][27094] Running state [attr] at time 03:52:32.896083
2017-12-17 03:52:32,896 [salt.state       ][INFO    ][27094] Executing state pkg.installed for attr
2017-12-17 03:52:32,897 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-17 03:52:33,171 [salt.state       ][INFO    ][27094] Package attr is already installed
2017-12-17 03:52:33,171 [salt.state       ][INFO    ][27094] Completed state [attr] at time 03:52:33.171121 duration_in_ms=275.038
2017-12-17 03:52:33,171 [salt.state       ][INFO    ][27094] Running state [glusterfs-server] at time 03:52:33.171302
2017-12-17 03:52:33,171 [salt.state       ][INFO    ][27094] Executing state pkg.installed for glusterfs-server
2017-12-17 03:52:33,174 [salt.state       ][INFO    ][27094] Package glusterfs-server is already installed
2017-12-17 03:52:33,174 [salt.state       ][INFO    ][27094] Completed state [glusterfs-server] at time 03:52:33.174181 duration_in_ms=2.878
2017-12-17 03:52:33,174 [salt.state       ][INFO    ][27094] Running state [bc] at time 03:52:33.174320
2017-12-17 03:52:33,174 [salt.state       ][INFO    ][27094] Executing state pkg.installed for bc
2017-12-17 03:52:33,177 [salt.state       ][INFO    ][27094] Package bc is already installed
2017-12-17 03:52:33,177 [salt.state       ][INFO    ][27094] Completed state [bc] at time 03:52:33.177040 duration_in_ms=2.72
2017-12-17 03:52:33,178 [salt.state       ][INFO    ][27094] Running state [glusterd] at time 03:52:33.177772
2017-12-17 03:52:33,178 [salt.state       ][INFO    ][27094] Executing state service.running for glusterd
2017-12-17 03:52:33,178 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command ['systemctl', 'status', 'glusterd.service', '-n', '0'] in directory '/root'
2017-12-17 03:52:33,195 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command ['systemctl', 'is-active', 'glusterd.service'] in directory '/root'
2017-12-17 03:52:33,203 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command ['systemctl', 'is-enabled', 'glusterd.service'] in directory '/root'
2017-12-17 03:52:33,210 [salt.state       ][INFO    ][27094] The service glusterd is already running
2017-12-17 03:52:33,210 [salt.state       ][INFO    ][27094] Completed state [glusterd] at time 03:52:33.210266 duration_in_ms=32.493
2017-12-17 03:52:33,212 [salt.state       ][INFO    ][27094] Running state [/etc/systemd/system/glusterd.service.d/override.conf] at time 03:52:33.211750
2017-12-17 03:52:33,212 [salt.state       ][INFO    ][27094] Executing state file.managed for /etc/systemd/system/glusterd.service.d/override.conf
2017-12-17 03:52:33,220 [salt.state       ][INFO    ][27094] File /etc/systemd/system/glusterd.service.d/override.conf is in the correct state
2017-12-17 03:52:33,220 [salt.state       ][INFO    ][27094] Completed state [/etc/systemd/system/glusterd.service.d/override.conf] at time 03:52:33.219700 duration_in_ms=7.95
2017-12-17 03:52:33,220 [salt.state       ][INFO    ][27094] Running state [/srv/glusterfs/glance] at time 03:52:33.219844
2017-12-17 03:52:33,220 [salt.state       ][INFO    ][27094] Executing state file.directory for /srv/glusterfs/glance
2017-12-17 03:52:33,220 [salt.state       ][INFO    ][27094] Directory /srv/glusterfs/glance is in the correct state
2017-12-17 03:52:33,220 [salt.state       ][INFO    ][27094] Completed state [/srv/glusterfs/glance] at time 03:52:33.220442 duration_in_ms=0.597
2017-12-17 03:52:33,221 [salt.state       ][INFO    ][27094] Running state [/srv/glusterfs/keystone-keys] at time 03:52:33.220580
2017-12-17 03:52:33,221 [salt.state       ][INFO    ][27094] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-17 03:52:33,221 [salt.state       ][INFO    ][27094] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-17 03:52:33,221 [salt.state       ][INFO    ][27094] Completed state [/srv/glusterfs/keystone-keys] at time 03:52:33.221154 duration_in_ms=0.574
2017-12-17 03:52:33,221 [salt.state       ][INFO    ][27094] Running state [/srv/glusterfs/nova_instances] at time 03:52:33.221294
2017-12-17 03:52:33,221 [salt.state       ][INFO    ][27094] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-17 03:52:33,222 [salt.state       ][INFO    ][27094] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-17 03:52:33,222 [salt.state       ][INFO    ][27094] Completed state [/srv/glusterfs/nova_instances] at time 03:52:33.221914 duration_in_ms=0.62
2017-12-17 03:52:33,222 [salt.state       ][INFO    ][27094] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:52:33.222046
2017-12-17 03:52:33,222 [salt.state       ][INFO    ][27094] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-17 03:52:33,223 [salt.state       ][INFO    ][27094] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-17 03:52:33,223 [salt.state       ][INFO    ][27094] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:52:33.222616 duration_in_ms=0.569
2017-12-17 03:52:33,257 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command ['git', '--version'] in directory '/root'
2017-12-17 03:52:33,299 [salt.state       ][INFO    ][27094] Running state [sleep 5] at time 03:52:33.298895
2017-12-17 03:52:33,299 [salt.state       ][INFO    ][27094] Executing state cmd.wait for sleep 5
2017-12-17 03:52:33,299 [salt.state       ][INFO    ][27094] No changes made for sleep 5
2017-12-17 03:52:33,299 [salt.state       ][INFO    ][27094] Completed state [sleep 5] at time 03:52:33.299423 duration_in_ms=0.529
2017-12-17 03:52:33,300 [salt.state       ][INFO    ][27094] Running state [10.167.4.141] at time 03:52:33.299848
2017-12-17 03:52:33,300 [salt.state       ][INFO    ][27094] Executing state glusterfs.peered for 10.167.4.141
2017-12-17 03:52:33,300 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:33,310 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:33,365 [salt.state       ][INFO    ][27094] Host 10.167.4.141 already peered
2017-12-17 03:52:33,365 [salt.state       ][INFO    ][27094] Completed state [10.167.4.141] at time 03:52:33.365319 duration_in_ms=65.47
2017-12-17 03:52:33,368 [salt.state       ][INFO    ][27094] Running state [10.167.4.142] at time 03:52:33.367587
2017-12-17 03:52:33,368 [salt.state       ][INFO    ][27094] Executing state glusterfs.peered for 10.167.4.142
2017-12-17 03:52:33,368 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:33,378 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:33,430 [salt.state       ][INFO    ][27094] Host 10.167.4.142 already peered
2017-12-17 03:52:33,430 [salt.state       ][INFO    ][27094] Completed state [10.167.4.142] at time 03:52:33.429791 duration_in_ms=62.204
2017-12-17 03:52:33,432 [salt.state       ][INFO    ][27094] Running state [10.167.4.143] at time 03:52:33.432088
2017-12-17 03:52:33,432 [salt.state       ][INFO    ][27094] Executing state glusterfs.peered for 10.167.4.143
2017-12-17 03:52:33,433 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:33,442 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:33,494 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:33,503 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:33,557 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:33,567 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:33,621 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:33,631 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:33,684 [salt.state       ][INFO    ][27094] Peering with localhost is not needed
2017-12-17 03:52:33,685 [salt.state       ][INFO    ][27094] Completed state [10.167.4.143] at time 03:52:33.684479 duration_in_ms=252.39
2017-12-17 03:52:33,685 [salt.state       ][INFO    ][27094] Running state [glance] at time 03:52:33.685289
2017-12-17 03:52:33,686 [salt.state       ][INFO    ][27094] Executing state glusterfs.created for glance
2017-12-17 03:52:33,686 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:33,695 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:33,747 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:33,756 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:33,812 [salt.state       ][INFO    ][27094] Volume glance already exists and is started.
2017-12-17 03:52:33,812 [salt.state       ][INFO    ][27094] Completed state [glance] at time 03:52:33.812097 duration_in_ms=126.808
2017-12-17 03:52:33,815 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:52:33.815411
2017-12-17 03:52:33,816 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-17 03:52:33,816 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-17 03:52:33,868 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:33,868 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:52:33.868164 duration_in_ms=52.752
2017-12-17 03:52:33,869 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:52:33.868635
2017-12-17 03:52:33,869 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-17 03:52:33,869 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-17 03:52:33,922 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:33,922 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:52:33.922169 duration_in_ms=53.532
2017-12-17 03:52:33,923 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:52:33.922660
2017-12-17 03:52:33,923 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-17 03:52:33,923 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-17 03:52:33,974 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:33,975 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:52:33.974577 duration_in_ms=51.915
2017-12-17 03:52:33,975 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 03:52:33.975022
2017-12-17 03:52:33,975 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-17 03:52:33,976 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-17 03:52:34,028 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:34,028 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 03:52:34.028291 duration_in_ms=53.269
2017-12-17 03:52:34,029 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:52:34.028760
2017-12-17 03:52:34,029 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-17 03:52:34,029 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-17 03:52:34,082 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:34,082 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:52:34.082418 duration_in_ms=53.658
2017-12-17 03:52:34,083 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:52:34.082860
2017-12-17 03:52:34,083 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-17 03:52:34,084 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-17 03:52:34,133 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:34,133 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:52:34.133236 duration_in_ms=50.375
2017-12-17 03:52:34,134 [salt.state       ][INFO    ][27094] Running state [glance] at time 03:52:34.134422
2017-12-17 03:52:34,135 [salt.state       ][INFO    ][27094] Executing state glusterfs.started for glance
2017-12-17 03:52:34,135 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:34,143 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:34,193 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:34,201 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:34,256 [salt.state       ][INFO    ][27094] Volume glance is already started
2017-12-17 03:52:34,256 [salt.state       ][INFO    ][27094] Completed state [glance] at time 03:52:34.255723 duration_in_ms=121.3
2017-12-17 03:52:34,257 [salt.state       ][INFO    ][27094] Running state [keystone-keys] at time 03:52:34.256536
2017-12-17 03:52:34,257 [salt.state       ][INFO    ][27094] Executing state glusterfs.created for keystone-keys
2017-12-17 03:52:34,257 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:34,266 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:34,315 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:34,325 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:34,380 [salt.state       ][INFO    ][27094] Volume keystone-keys already exists and is started.
2017-12-17 03:52:34,380 [salt.state       ][INFO    ][27094] Completed state [keystone-keys] at time 03:52:34.380389 duration_in_ms=123.852
2017-12-17 03:52:34,384 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:52:34.384033
2017-12-17 03:52:34,384 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-17 03:52:34,385 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-17 03:52:34,437 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:34,437 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:52:34.436771 duration_in_ms=52.737
2017-12-17 03:52:34,437 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:52:34.437249
2017-12-17 03:52:34,437 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-17 03:52:34,438 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-17 03:52:34,490 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:34,490 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:52:34.490149 duration_in_ms=52.9
2017-12-17 03:52:34,491 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 03:52:34.490627
2017-12-17 03:52:34,491 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-17 03:52:34,491 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-17 03:52:34,543 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:34,543 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 03:52:34.543318 duration_in_ms=52.69
2017-12-17 03:52:34,544 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:52:34.543758
2017-12-17 03:52:34,544 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-17 03:52:34,544 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-17 03:52:34,598 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:34,598 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:52:34.597798 duration_in_ms=54.039
2017-12-17 03:52:34,598 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:52:34.598265
2017-12-17 03:52:34,598 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-17 03:52:34,599 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-17 03:52:34,650 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:34,650 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:52:34.649787 duration_in_ms=51.522
2017-12-17 03:52:34,650 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:52:34.650247
2017-12-17 03:52:34,650 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-17 03:52:34,651 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-17 03:52:34,702 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:34,702 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:52:34.702165 duration_in_ms=51.918
2017-12-17 03:52:34,703 [salt.state       ][INFO    ][27094] Running state [keystone-keys] at time 03:52:34.703343
2017-12-17 03:52:34,704 [salt.state       ][INFO    ][27094] Executing state glusterfs.started for keystone-keys
2017-12-17 03:52:34,704 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:34,713 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:34,766 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:34,775 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:34,830 [salt.state       ][INFO    ][27094] Volume keystone-keys is already started
2017-12-17 03:52:34,831 [salt.state       ][INFO    ][27094] Completed state [keystone-keys] at time 03:52:34.830546 duration_in_ms=127.202
2017-12-17 03:52:34,831 [salt.state       ][INFO    ][27094] Running state [nova_instances] at time 03:52:34.831431
2017-12-17 03:52:34,832 [salt.state       ][INFO    ][27094] Executing state glusterfs.created for nova_instances
2017-12-17 03:52:34,832 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:34,841 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:34,893 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:34,902 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:34,957 [salt.state       ][INFO    ][27094] Volume nova_instances already exists and is started.
2017-12-17 03:52:34,957 [salt.state       ][INFO    ][27094] Completed state [nova_instances] at time 03:52:34.957342 duration_in_ms=125.91
2017-12-17 03:52:34,961 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:52:34.960923
2017-12-17 03:52:34,961 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-17 03:52:34,962 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-17 03:52:35,017 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:35,017 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:52:35.017434 duration_in_ms=56.511
2017-12-17 03:52:35,018 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 03:52:35.017945
2017-12-17 03:52:35,018 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-17 03:52:35,019 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-17 03:52:35,071 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:35,071 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 03:52:35.071143 duration_in_ms=53.197
2017-12-17 03:52:35,072 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 03:52:35.071636
2017-12-17 03:52:35,072 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-17 03:52:35,072 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-17 03:52:35,126 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:35,126 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 03:52:35.125960 duration_in_ms=54.324
2017-12-17 03:52:35,127 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 03:52:35.126469
2017-12-17 03:52:35,127 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-17 03:52:35,127 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-17 03:52:35,184 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:35,184 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 03:52:35.184421 duration_in_ms=57.95
2017-12-17 03:52:35,185 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 03:52:35.184930
2017-12-17 03:52:35,185 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-17 03:52:35,186 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-17 03:52:35,240 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:35,241 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 03:52:35.240646 duration_in_ms=55.715
2017-12-17 03:52:35,241 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:52:35.241125
2017-12-17 03:52:35,241 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-17 03:52:35,242 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-17 03:52:35,294 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:35,294 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:52:35.294267 duration_in_ms=53.141
2017-12-17 03:52:35,295 [salt.state       ][INFO    ][27094] Running state [nova_instances] at time 03:52:35.295454
2017-12-17 03:52:35,296 [salt.state       ][INFO    ][27094] Executing state glusterfs.started for nova_instances
2017-12-17 03:52:35,296 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:35,305 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:35,354 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:35,362 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:35,415 [salt.state       ][INFO    ][27094] Volume nova_instances is already started
2017-12-17 03:52:35,415 [salt.state       ][INFO    ][27094] Completed state [nova_instances] at time 03:52:35.415160 duration_in_ms=119.705
2017-12-17 03:52:35,416 [salt.state       ][INFO    ][27094] Running state [keystone-credential-keys] at time 03:52:35.416037
2017-12-17 03:52:35,416 [salt.state       ][INFO    ][27094] Executing state glusterfs.created for keystone-credential-keys
2017-12-17 03:52:35,417 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:35,425 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:35,473 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:35,483 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:35,540 [salt.state       ][INFO    ][27094] Volume keystone-credential-keys already exists and is started.
2017-12-17 03:52:35,540 [salt.state       ][INFO    ][27094] Completed state [keystone-credential-keys] at time 03:52:35.540418 duration_in_ms=124.381
2017-12-17 03:52:35,545 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:52:35.545216
2017-12-17 03:52:35,546 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-17 03:52:35,547 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-17 03:52:35,604 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:35,604 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:52:35.604025 duration_in_ms=58.808
2017-12-17 03:52:35,605 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 03:52:35.604561
2017-12-17 03:52:35,605 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-17 03:52:35,605 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-17 03:52:35,659 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:35,659 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 03:52:35.658790 duration_in_ms=54.229
2017-12-17 03:52:35,659 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:52:35.659267
2017-12-17 03:52:35,660 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-17 03:52:35,660 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-17 03:52:35,711 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:35,712 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:52:35.711530 duration_in_ms=52.262
2017-12-17 03:52:35,712 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:52:35.712019
2017-12-17 03:52:35,712 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-17 03:52:35,713 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-17 03:52:35,765 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:35,765 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:52:35.765240 duration_in_ms=53.221
2017-12-17 03:52:35,766 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:52:35.765758
2017-12-17 03:52:35,766 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-17 03:52:35,767 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-17 03:52:35,818 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:35,818 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:52:35.817861 duration_in_ms=52.102
2017-12-17 03:52:35,818 [salt.state       ][INFO    ][27094] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:52:35.818364
2017-12-17 03:52:35,819 [salt.state       ][INFO    ][27094] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-17 03:52:35,819 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-17 03:52:35,877 [salt.state       ][INFO    ][27094] unless execution succeeded
2017-12-17 03:52:35,877 [salt.state       ][INFO    ][27094] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:52:35.876957 duration_in_ms=58.592
2017-12-17 03:52:35,878 [salt.state       ][INFO    ][27094] Running state [keystone-credential-keys] at time 03:52:35.878228
2017-12-17 03:52:35,879 [salt.state       ][INFO    ][27094] Executing state glusterfs.started for keystone-credential-keys
2017-12-17 03:52:35,879 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:35,889 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:35,941 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --version' in directory '/root'
2017-12-17 03:52:35,951 [salt.loaded.int.module.cmdmod][INFO    ][27094] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-17 03:52:36,007 [salt.state       ][INFO    ][27094] Volume keystone-credential-keys is already started
2017-12-17 03:52:36,007 [salt.state       ][INFO    ][27094] Completed state [keystone-credential-keys] at time 03:52:36.006923 duration_in_ms=128.695
2017-12-17 03:52:36,009 [salt.minion      ][INFO    ][27094] Returning information for job: 20171217035232001413
2017-12-17 03:52:37,168 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command test.ping with jid 20171217035237162511
2017-12-17 03:52:37,184 [salt.minion      ][INFO    ][27670] Starting a new job with PID 27670
2017-12-17 03:52:37,212 [salt.minion      ][INFO    ][27670] Returning information for job: 20171217035237162511
2017-12-17 03:52:37,890 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command cmd.run with jid 20171217035237879885
2017-12-17 03:52:37,905 [salt.minion      ][INFO    ][27675] Starting a new job with PID 27675
2017-12-17 03:52:37,909 [salt.loaded.int.module.cmdmod][INFO    ][27675] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-17 03:52:38,024 [salt.minion      ][INFO    ][27675] Returning information for job: 20171217035237879885
2017-12-17 04:12:44,622 [salt.utils.schedule][INFO    ][7812] Running scheduled job: __mine_interval
2017-12-17 04:16:01,997 [salt.minion      ][INFO    ][7812] User sudo_ubuntu Executing command cp.push_dir with jid 20171217041601991470
2017-12-17 04:16:02,020 [salt.minion      ][INFO    ][27881] Starting a new job with PID 27881
