2017-10-27 23:20:09,106 [salt.cli.daemons ][WARNING ][2319] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 23:21:14,414 [salt.state       ][ERROR   ][3932] No contents found in top file
2017-10-27 23:23:50,430 [salt.utils.parsers][WARNING ][2319] Minion received a SIGTERM. Exiting.
2017-10-27 23:28:13,364 [salt.cli.daemons ][WARNING ][3571] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 23:30:23,482 [salt.loaded.int.module.cmdmod][ERROR   ][11705] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-10-27 23:30:23,483 [salt.loaded.int.module.cmdmod][ERROR   ][11705] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-10-27 23:30:23,483 [salt.loaded.int.module.cmdmod][ERROR   ][11705] retcode: 1
2017-10-27 23:30:23,483 [salt.state       ][ERROR   ][11705] {'pid': 16648, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-10-27 23:30:40,172 [py.warnings      ][WARNING ][16725] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-27 23:31:07,547 [salt.loaded.int.module.cmdmod][ERROR   ][16725] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 23:31:07,552 [salt.loaded.int.module.cmdmod][ERROR   ][16725] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 23:31:12,594 [salt.loaded.int.module.cmdmod][ERROR   ][16725] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 23:31:12,595 [salt.loaded.int.module.cmdmod][ERROR   ][16725] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 23:31:17,589 [salt.loaded.int.module.cmdmod][ERROR   ][16725] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 23:31:17,590 [salt.loaded.int.module.cmdmod][ERROR   ][16725] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 23:31:22,768 [salt.loaded.int.module.cmdmod][ERROR   ][16725] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 23:31:22,769 [salt.loaded.int.module.cmdmod][ERROR   ][16725] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 23:31:26,652 [salt.loaded.int.module.cmdmod][ERROR   ][16725] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-10-27 23:31:30,317 [salt.state       ][ERROR   ][24217] No contents found in top file
2017-10-27 23:31:35,575 [py.warnings      ][WARNING ][24510] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-27 23:31:41,412 [salt.loaded.int.module.cmdmod][INFO    ][24837] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-27 23:31:41,425 [salt.loaded.int.module.cmdmod][INFO    ][24837] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-27 23:31:41,452 [salt.loaded.int.module.cmdmod][INFO    ][24837] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-10-27 23:31:41,474 [salt.utils.parsers][WARNING ][3571] Minion received a SIGTERM. Exiting.
2017-10-27 23:31:41,921 [salt.cli.daemons ][INFO    ][24923] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-10-27 23:31:42,841 [salt.minion      ][INFO    ][24923] Creating minion process manager
2017-10-27 23:31:42,842 [salt.cli.daemons ][WARNING ][24923] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 23:31:42,842 [salt.cli.daemons ][INFO    ][24923] The Salt Minion is starting up
2017-10-27 23:31:42,843 [salt.minion      ][INFO    ][24923] Minion is starting as user 'root'
2017-10-27 23:31:42,843 [salt.utils.event ][INFO    ][24923] Starting pull socket on /var/run/salt/minion/minion_event_0031115955_pull.ipc
2017-10-27 23:31:44,280 [salt.loaded.int.module.cmdmod][INFO    ][24923] Executing command ['date', '+%z'] in directory '/root'
2017-10-27 23:31:44,299 [salt.utils.schedule][INFO    ][24923] Updating job settings for scheduled job: __mine_interval
2017-10-27 23:31:44,302 [salt.minion      ][INFO    ][24923] Added mine.update to scheduler
2017-10-27 23:31:44,324 [salt.minion      ][INFO    ][24923] Minion is ready to receive requests!
2017-10-27 23:31:45,326 [salt.utils.schedule][INFO    ][24923] Running scheduled job: __mine_interval
2017-10-27 23:32:05,141 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command state.sls with jid 20171027233205130174
2017-10-27 23:32:05,159 [salt.minion      ][INFO    ][25047] Starting a new job with PID 25047
2017-10-27 23:32:07,761 [salt.state       ][INFO    ][25047] Loading fresh modules for state activity
2017-10-27 23:32:07,797 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-27 23:32:07,826 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-27 23:32:07,865 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 23:32:07,972 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-27 23:32:07,994 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-27 23:32:08,033 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 23:32:08,121 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 23:32:08,149 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 23:32:08,281 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 23:32:08,306 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 23:32:08,324 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 23:32:08,345 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 23:32:08,357 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 23:32:08,393 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 23:32:08,419 [py.warnings      ][WARNING ][25047] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-27 23:32:08,420 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 23:32:08,733 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 23:32:08,751 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 23:32:08,770 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 23:32:08,785 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 23:32:08,860 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 23:32:08,913 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 23:32:09,000 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-27 23:32:09,032 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 23:32:09,114 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 23:32:09,137 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 23:32:09,197 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 23:32:09,225 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 23:32:09,243 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 23:32:09,267 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 23:32:09,290 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 23:32:09,331 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 23:32:09,352 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 23:32:09,679 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 23:32:09,702 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 23:32:09,717 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 23:32:09,733 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 23:32:09,796 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 23:32:09,847 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 23:32:09,938 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-27 23:32:10,025 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 23:32:10,401 [salt.state       ][INFO    ][25047] Running state [salt-minion] at time 23:32:10.401065
2017-10-27 23:32:10,401 [salt.state       ][INFO    ][25047] Executing state pkg.installed for salt-minion
2017-10-27 23:32:10,402 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 23:32:10,710 [salt.state       ][INFO    ][25047] Package salt-minion is already installed
2017-10-27 23:32:10,710 [salt.state       ][INFO    ][25047] Completed state [salt-minion] at time 23:32:10.710371 duration_in_ms=309.306
2017-10-27 23:32:10,711 [salt.state       ][INFO    ][25047] Running state [salt_minion_dependency_packages] at time 23:32:10.710658
2017-10-27 23:32:10,711 [salt.state       ][INFO    ][25047] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-27 23:32:10,715 [salt.state       ][INFO    ][25047] All specified packages are already installed
2017-10-27 23:32:10,715 [salt.state       ][INFO    ][25047] Completed state [salt_minion_dependency_packages] at time 23:32:10.714895 duration_in_ms=4.237
2017-10-27 23:32:10,717 [salt.state       ][INFO    ][25047] Running state [/etc/salt/minion.d/minion.conf] at time 23:32:10.716622
2017-10-27 23:32:10,717 [salt.state       ][INFO    ][25047] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-27 23:32:10,745 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-27 23:32:10,813 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 23:32:10,877 [salt.fileclient  ][INFO    ][25047] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 23:32:10,931 [salt.state       ][INFO    ][25047] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-27 23:32:10,931 [salt.state       ][INFO    ][25047] Completed state [/etc/salt/minion.d/minion.conf] at time 23:32:10.931253 duration_in_ms=214.631
2017-10-27 23:32:10,932 [salt.state       ][INFO    ][25047] Running state [/etc/salt/minion.d/_virt.conf] at time 23:32:10.931633
2017-10-27 23:32:10,932 [salt.state       ][INFO    ][25047] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-27 23:32:10,933 [salt.state       ][INFO    ][25047] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-27 23:32:10,933 [salt.state       ][INFO    ][25047] Completed state [/etc/salt/minion.d/_virt.conf] at time 23:32:10.932685 duration_in_ms=1.052
2017-10-27 23:32:10,934 [salt.state       ][INFO    ][25047] Running state [salt-minion] at time 23:32:10.934307
2017-10-27 23:32:10,935 [salt.state       ][INFO    ][25047] Executing state service.running for salt-minion
2017-10-27 23:32:10,935 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-27 23:32:10,968 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-27 23:32:10,986 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-27 23:32:11,003 [salt.state       ][INFO    ][25047] The service salt-minion is already running
2017-10-27 23:32:11,003 [salt.state       ][INFO    ][25047] Completed state [salt-minion] at time 23:32:11.003156 duration_in_ms=68.847
2017-10-27 23:32:11,010 [salt.state       ][INFO    ][25047] Running state [/etc/salt/grains.d] at time 23:32:11.009700
2017-10-27 23:32:11,010 [salt.state       ][INFO    ][25047] Executing state file.directory for /etc/salt/grains.d
2017-10-27 23:32:11,012 [salt.state       ][INFO    ][25047] Directory /etc/salt/grains.d is in the correct state
2017-10-27 23:32:11,013 [salt.state       ][INFO    ][25047] Completed state [/etc/salt/grains.d] at time 23:32:11.012557 duration_in_ms=2.857
2017-10-27 23:32:11,014 [salt.state       ][INFO    ][25047] Running state [/etc/salt/grains] at time 23:32:11.013764
2017-10-27 23:32:11,014 [salt.state       ][INFO    ][25047] Executing state file.managed for /etc/salt/grains
2017-10-27 23:32:11,015 [salt.state       ][INFO    ][25047] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-27 23:32:11,015 [salt.state       ][INFO    ][25047] Completed state [/etc/salt/grains] at time 23:32:11.015410 duration_in_ms=1.645
2017-10-27 23:32:11,017 [salt.state       ][INFO    ][25047] Running state [/etc/salt/grains.d/placeholder] at time 23:32:11.017065
2017-10-27 23:32:11,018 [salt.state       ][INFO    ][25047] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-27 23:32:11,018 [salt.state       ][INFO    ][25047] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-27 23:32:11,019 [salt.state       ][INFO    ][25047] Completed state [/etc/salt/grains.d/placeholder] at time 23:32:11.018663 duration_in_ms=1.599
2017-10-27 23:32:11,020 [salt.state       ][INFO    ][25047] Running state [/etc/salt/grains.d/sphinx] at time 23:32:11.019646
2017-10-27 23:32:11,021 [salt.state       ][INFO    ][25047] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-27 23:32:11,022 [salt.state       ][INFO    ][25047] File /etc/salt/grains.d/sphinx is in the correct state
2017-10-27 23:32:11,022 [salt.state       ][INFO    ][25047] Completed state [/etc/salt/grains.d/sphinx] at time 23:32:11.021780 duration_in_ms=2.135
2017-10-27 23:32:11,023 [salt.state       ][INFO    ][25047] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 23:32:11.022496
2017-10-27 23:32:11,023 [salt.state       ][INFO    ][25047] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 23:32:11,023 [salt.state       ][INFO    ][25047] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 23:32:11,023 [salt.state       ][INFO    ][25047] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 23:32:11.023462 duration_in_ms=0.966
2017-10-27 23:32:11,024 [salt.state       ][INFO    ][25047] Running state [/etc/salt/grains.d/dns_records] at time 23:32:11.024405
2017-10-27 23:32:11,025 [salt.state       ][INFO    ][25047] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-27 23:32:11,025 [salt.state       ][INFO    ][25047] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-27 23:32:11,026 [salt.state       ][INFO    ][25047] Completed state [/etc/salt/grains.d/dns_records] at time 23:32:11.025401 duration_in_ms=0.996
2017-10-27 23:32:11,027 [salt.state       ][INFO    ][25047] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 23:32:11.026484
2017-10-27 23:32:11,027 [salt.state       ][INFO    ][25047] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 23:32:11,027 [salt.state       ][INFO    ][25047] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 23:32:11,027 [salt.state       ][INFO    ][25047] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 23:32:11.027069 duration_in_ms=0.585
2017-10-27 23:32:11,027 [salt.state       ][INFO    ][25047] Running state [/etc/salt/grains.d/salt] at time 23:32:11.027413
2017-10-27 23:32:11,028 [salt.state       ][INFO    ][25047] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-27 23:32:11,029 [salt.state       ][INFO    ][25047] File /etc/salt/grains.d/salt is in the correct state
2017-10-27 23:32:11,029 [salt.state       ][INFO    ][25047] Completed state [/etc/salt/grains.d/salt] at time 23:32:11.029337 duration_in_ms=1.924
2017-10-27 23:32:11,030 [salt.state       ][INFO    ][25047] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 23:32:11.030044
2017-10-27 23:32:11,030 [salt.state       ][INFO    ][25047] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 23:32:11,031 [salt.state       ][INFO    ][25047] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 23:32:11,031 [salt.state       ][INFO    ][25047] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 23:32:11.030637 duration_in_ms=0.593
2017-10-27 23:32:11,033 [salt.state       ][INFO    ][25047] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 23:32:11.033106
2017-10-27 23:32:11,034 [salt.state       ][INFO    ][25047] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 23:32:11,034 [salt.state       ][INFO    ][25047] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 23:32:11,034 [salt.state       ][INFO    ][25047] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 23:32:11.034071 duration_in_ms=0.965
2017-10-27 23:32:11,035 [salt.state       ][INFO    ][25047] Running state [mine.update] at time 23:32:11.034588
2017-10-27 23:32:11,035 [salt.state       ][INFO    ][25047] Executing state module.wait for mine.update
2017-10-27 23:32:11,035 [salt.state       ][INFO    ][25047] No changes made for mine.update
2017-10-27 23:32:11,035 [salt.state       ][INFO    ][25047] Completed state [mine.update] at time 23:32:11.035122 duration_in_ms=0.534
2017-10-27 23:32:11,035 [salt.state       ][INFO    ][25047] Running state [ca-certificates] at time 23:32:11.035300
2017-10-27 23:32:11,035 [salt.state       ][INFO    ][25047] Executing state pkg.installed for ca-certificates
2017-10-27 23:32:11,040 [salt.state       ][INFO    ][25047] Package ca-certificates is already installed
2017-10-27 23:32:11,040 [salt.state       ][INFO    ][25047] Completed state [ca-certificates] at time 23:32:11.039662 duration_in_ms=4.362
2017-10-27 23:32:11,041 [salt.state       ][INFO    ][25047] Running state [update-ca-certificates] at time 23:32:11.041148
2017-10-27 23:32:11,041 [salt.state       ][INFO    ][25047] Executing state cmd.wait for update-ca-certificates
2017-10-27 23:32:11,042 [salt.state       ][INFO    ][25047] No changes made for update-ca-certificates
2017-10-27 23:32:11,042 [salt.state       ][INFO    ][25047] Completed state [update-ca-certificates] at time 23:32:11.041719 duration_in_ms=0.571
2017-10-27 23:32:11,042 [salt.state       ][INFO    ][25047] Running state [libvirt-dev] at time 23:32:11.041898
2017-10-27 23:32:11,042 [salt.state       ][INFO    ][25047] Executing state pkg.installed for libvirt-dev
2017-10-27 23:32:11,046 [salt.state       ][INFO    ][25047] Package libvirt-dev is already installed
2017-10-27 23:32:11,046 [salt.state       ][INFO    ][25047] Completed state [libvirt-dev] at time 23:32:11.045904 duration_in_ms=4.006
2017-10-27 23:32:11,046 [salt.state       ][INFO    ][25047] Running state [pkg-config] at time 23:32:11.046426
2017-10-27 23:32:11,047 [salt.state       ][INFO    ][25047] Executing state pkg.installed for pkg-config
2017-10-27 23:32:11,051 [salt.state       ][INFO    ][25047] Package pkg-config is already installed
2017-10-27 23:32:11,051 [salt.state       ][INFO    ][25047] Completed state [pkg-config] at time 23:32:11.050744 duration_in_ms=4.318
2017-10-27 23:32:11,051 [salt.state       ][INFO    ][25047] Running state [virtng.init] at time 23:32:11.050939
2017-10-27 23:32:11,051 [salt.state       ][INFO    ][25047] Executing state module.run for virtng.init
2017-10-27 23:32:11,126 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command ['git', '--version'] in directory '/root'
2017-10-27 23:32:11,176 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-27 23:32:11,209 [salt.state       ][INFO    ][25047] unless execution succeeded
2017-10-27 23:32:11,210 [salt.state       ][INFO    ][25047] Completed state [virtng.init] at time 23:32:11.209759 duration_in_ms=158.818
2017-10-27 23:32:11,210 [salt.state       ][INFO    ][25047] Running state [virt.set_autostart] at time 23:32:11.210363
2017-10-27 23:32:11,211 [salt.state       ][INFO    ][25047] Executing state module.run for virt.set_autostart
2017-10-27 23:32:11,217 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-27 23:32:11,253 [salt.state       ][INFO    ][25047] unless execution succeeded
2017-10-27 23:32:11,253 [salt.state       ][INFO    ][25047] Completed state [virt.set_autostart] at time 23:32:11.253346 duration_in_ms=42.982
2017-10-27 23:32:11,254 [salt.state       ][INFO    ][25047] Running state [virtng.init] at time 23:32:11.253892
2017-10-27 23:32:11,255 [salt.state       ][INFO    ][25047] Executing state module.run for virtng.init
2017-10-27 23:32:11,263 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-27 23:32:11,299 [salt.state       ][INFO    ][25047] unless execution succeeded
2017-10-27 23:32:11,299 [salt.state       ][INFO    ][25047] Completed state [virtng.init] at time 23:32:11.299269 duration_in_ms=45.376
2017-10-27 23:32:11,302 [salt.state       ][INFO    ][25047] Running state [virt.set_autostart] at time 23:32:11.301533
2017-10-27 23:32:11,302 [salt.state       ][INFO    ][25047] Executing state module.run for virt.set_autostart
2017-10-27 23:32:11,308 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-27 23:32:11,341 [salt.state       ][INFO    ][25047] unless execution succeeded
2017-10-27 23:32:11,342 [salt.state       ][INFO    ][25047] Completed state [virt.set_autostart] at time 23:32:11.342092 duration_in_ms=40.557
2017-10-27 23:32:11,343 [salt.state       ][INFO    ][25047] Running state [virtng.init] at time 23:32:11.342641
2017-10-27 23:32:11,343 [salt.state       ][INFO    ][25047] Executing state module.run for virtng.init
2017-10-27 23:32:11,351 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-27 23:32:11,385 [salt.state       ][INFO    ][25047] unless execution succeeded
2017-10-27 23:32:11,385 [salt.state       ][INFO    ][25047] Completed state [virtng.init] at time 23:32:11.385019 duration_in_ms=42.378
2017-10-27 23:32:11,385 [salt.state       ][INFO    ][25047] Running state [virt.set_autostart] at time 23:32:11.385278
2017-10-27 23:32:11,386 [salt.state       ][INFO    ][25047] Executing state module.run for virt.set_autostart
2017-10-27 23:32:11,390 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-27 23:32:11,425 [salt.state       ][INFO    ][25047] unless execution succeeded
2017-10-27 23:32:11,426 [salt.state       ][INFO    ][25047] Completed state [virt.set_autostart] at time 23:32:11.425734 duration_in_ms=40.455
2017-10-27 23:32:11,426 [salt.state       ][INFO    ][25047] Running state [virtng.init] at time 23:32:11.426158
2017-10-27 23:32:11,427 [salt.state       ][INFO    ][25047] Executing state module.run for virtng.init
2017-10-27 23:32:11,433 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-27 23:32:11,477 [salt.state       ][INFO    ][25047] unless execution succeeded
2017-10-27 23:32:11,477 [salt.state       ][INFO    ][25047] Completed state [virtng.init] at time 23:32:11.476851 duration_in_ms=50.693
2017-10-27 23:32:11,477 [salt.state       ][INFO    ][25047] Running state [virt.set_autostart] at time 23:32:11.477415
2017-10-27 23:32:11,478 [salt.state       ][INFO    ][25047] Executing state module.run for virt.set_autostart
2017-10-27 23:32:11,486 [salt.loaded.int.module.cmdmod][INFO    ][25047] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-10-27 23:32:11,523 [salt.state       ][INFO    ][25047] unless execution succeeded
2017-10-27 23:32:11,525 [salt.state       ][INFO    ][25047] Completed state [virt.set_autostart] at time 23:32:11.525360 duration_in_ms=47.945
2017-10-27 23:32:11,532 [salt.minion      ][INFO    ][25047] Returning information for job: 20171027233205130174
2017-10-27 23:32:31,040 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171027233231027488
2017-10-27 23:32:31,066 [salt.minion      ][INFO    ][25135] Starting a new job with PID 25135
2017-10-27 23:32:35,354 [salt.state       ][INFO    ][25135] Loading fresh modules for state activity
2017-10-27 23:32:35,400 [salt.state       ][ERROR   ][25135] No contents found in top file
2017-10-27 23:32:35,401 [salt.utils.extmods][INFO    ][25135] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-27 23:32:35,406 [salt.utils.extmods][INFO    ][25135] Syncing beacons for environment 'base'
2017-10-27 23:32:35,406 [salt.utils.extmods][INFO    ][25135] Loading cache from salt://_beacons, for base)
2017-10-27 23:32:35,407 [salt.fileclient  ][INFO    ][25135] Caching directory '_beacons/' for environment 'base'
2017-10-27 23:32:35,479 [salt.utils.extmods][INFO    ][25135] Syncing modules for environment 'base'
2017-10-27 23:32:35,480 [salt.utils.extmods][INFO    ][25135] Loading cache from salt://_modules, for base)
2017-10-27 23:32:35,480 [salt.fileclient  ][INFO    ][25135] Caching directory '_modules/' for environment 'base'
2017-10-27 23:32:35,549 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-27 23:32:35,571 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-27 23:32:36,103 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-27 23:32:36,129 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-27 23:32:36,147 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-27 23:32:36,171 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-27 23:32:36,195 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-27 23:32:36,219 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-27 23:32:36,246 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-27 23:32:36,269 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-27 23:32:36,280 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-27 23:32:36,295 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-27 23:32:36,327 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-27 23:32:36,344 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-27 23:32:36,367 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-27 23:32:36,412 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-27 23:32:36,434 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-27 23:32:36,449 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-27 23:32:36,465 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-27 23:32:36,478 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-27 23:32:36,506 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-27 23:32:36,525 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-27 23:32:36,541 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-27 23:32:36,559 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-27 23:32:36,585 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-27 23:32:36,602 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-27 23:32:36,635 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-27 23:32:36,676 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-27 23:32:36,691 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-27 23:32:36,706 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-27 23:32:36,726 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-27 23:32:36,748 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-27 23:32:36,757 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-27 23:32:36,757 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-27 23:32:36,757 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-27 23:32:36,758 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-27 23:32:36,758 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-27 23:32:36,759 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-27 23:32:36,759 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-27 23:32:36,760 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-27 23:32:36,761 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-27 23:32:36,761 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-27 23:32:36,762 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-27 23:32:36,762 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-27 23:32:36,763 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-27 23:32:36,763 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-27 23:32:36,764 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-27 23:32:36,764 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-27 23:32:36,765 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-27 23:32:36,765 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-27 23:32:36,765 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-27 23:32:36,765 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-27 23:32:36,766 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-27 23:32:36,766 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-27 23:32:36,766 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-27 23:32:36,767 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-27 23:32:36,767 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-27 23:32:36,768 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-27 23:32:36,769 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-27 23:32:36,769 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-27 23:32:36,769 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-27 23:32:36,770 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-27 23:32:36,770 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-27 23:32:36,770 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-10-27 23:32:36,770 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-27 23:32:36,771 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-27 23:32:36,781 [salt.utils.extmods][INFO    ][25135] Syncing states for environment 'base'
2017-10-27 23:32:36,781 [salt.utils.extmods][INFO    ][25135] Loading cache from salt://_states, for base)
2017-10-27 23:32:36,781 [salt.fileclient  ][INFO    ][25135] Caching directory '_states/' for environment 'base'
2017-10-27 23:32:36,878 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-27 23:32:36,893 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-27 23:32:36,927 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-27 23:32:36,940 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-27 23:32:36,952 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-27 23:32:36,979 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-27 23:32:36,997 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-27 23:32:37,024 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-27 23:32:37,053 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-27 23:32:37,074 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-27 23:32:37,104 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-27 23:32:37,118 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-27 23:32:37,138 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-27 23:32:37,157 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-27 23:32:37,174 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-27 23:32:37,197 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-27 23:32:37,216 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-27 23:32:37,264 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-27 23:32:37,285 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-27 23:32:37,303 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-27 23:32:37,327 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-27 23:32:37,349 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-27 23:32:37,387 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-27 23:32:37,431 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-27 23:32:37,467 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-27 23:32:37,486 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-27 23:32:37,525 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-27 23:32:37,554 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-27 23:32:37,567 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-27 23:32:37,577 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-27 23:32:37,578 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-27 23:32:37,578 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-27 23:32:37,579 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-27 23:32:37,579 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-27 23:32:37,580 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-27 23:32:37,580 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-27 23:32:37,580 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-27 23:32:37,581 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-27 23:32:37,581 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-27 23:32:37,581 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-27 23:32:37,581 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-27 23:32:37,582 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-27 23:32:37,582 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-27 23:32:37,583 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-27 23:32:37,583 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-27 23:32:37,583 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-27 23:32:37,583 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-27 23:32:37,584 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-27 23:32:37,585 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-27 23:32:37,585 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-27 23:32:37,585 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-27 23:32:37,585 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-27 23:32:37,586 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-27 23:32:37,586 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-27 23:32:37,586 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-27 23:32:37,587 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-27 23:32:37,587 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-27 23:32:37,587 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-27 23:32:37,588 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-27 23:32:37,593 [salt.utils.extmods][INFO    ][25135] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-27 23:32:37,597 [salt.utils.extmods][INFO    ][25135] Syncing sdb for environment 'base'
2017-10-27 23:32:37,598 [salt.utils.extmods][INFO    ][25135] Loading cache from salt://_sdb, for base)
2017-10-27 23:32:37,599 [salt.fileclient  ][INFO    ][25135] Caching directory '_sdb/' for environment 'base'
2017-10-27 23:32:37,655 [salt.utils.extmods][INFO    ][25135] Syncing grains for environment 'base'
2017-10-27 23:32:37,655 [salt.utils.extmods][INFO    ][25135] Loading cache from salt://_grains, for base)
2017-10-27 23:32:37,655 [salt.fileclient  ][INFO    ][25135] Caching directory '_grains/' for environment 'base'
2017-10-27 23:32:37,750 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-27 23:32:37,769 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-27 23:32:37,785 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-27 23:32:37,802 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-27 23:32:37,851 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-27 23:32:37,875 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-27 23:32:37,913 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-27 23:32:37,950 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-27 23:32:37,971 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-27 23:32:37,985 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-27 23:32:38,002 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-27 23:32:38,043 [salt.fileclient  ][INFO    ][25135] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-27 23:32:38,052 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-27 23:32:38,053 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-27 23:32:38,053 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-27 23:32:38,053 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-27 23:32:38,054 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-27 23:32:38,054 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-27 23:32:38,055 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-27 23:32:38,055 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-27 23:32:38,055 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-27 23:32:38,056 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-27 23:32:38,057 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-27 23:32:38,057 [salt.utils.extmods][INFO    ][25135] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-27 23:32:38,060 [salt.utils.extmods][INFO    ][25135] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-27 23:32:38,063 [salt.utils.extmods][INFO    ][25135] Syncing renderers for environment 'base'
2017-10-27 23:32:38,063 [salt.utils.extmods][INFO    ][25135] Loading cache from salt://_renderers, for base)
2017-10-27 23:32:38,063 [salt.fileclient  ][INFO    ][25135] Caching directory '_renderers/' for environment 'base'
2017-10-27 23:32:38,120 [salt.utils.extmods][INFO    ][25135] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-27 23:32:38,123 [salt.utils.extmods][INFO    ][25135] Syncing returners for environment 'base'
2017-10-27 23:32:38,123 [salt.utils.extmods][INFO    ][25135] Loading cache from salt://_returners, for base)
2017-10-27 23:32:38,124 [salt.fileclient  ][INFO    ][25135] Caching directory '_returners/' for environment 'base'
2017-10-27 23:32:38,189 [salt.utils.extmods][INFO    ][25135] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-27 23:32:38,193 [salt.utils.extmods][INFO    ][25135] Syncing output for environment 'base'
2017-10-27 23:32:38,193 [salt.utils.extmods][INFO    ][25135] Loading cache from salt://_output, for base)
2017-10-27 23:32:38,193 [salt.fileclient  ][INFO    ][25135] Caching directory '_output/' for environment 'base'
2017-10-27 23:32:38,253 [salt.utils.extmods][INFO    ][25135] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-27 23:32:38,257 [salt.utils.extmods][INFO    ][25135] Syncing utils for environment 'base'
2017-10-27 23:32:38,257 [salt.utils.extmods][INFO    ][25135] Loading cache from salt://_utils, for base)
2017-10-27 23:32:38,258 [salt.fileclient  ][INFO    ][25135] Caching directory '_utils/' for environment 'base'
2017-10-27 23:32:38,316 [salt.utils.extmods][INFO    ][25135] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-27 23:32:38,319 [salt.utils.extmods][INFO    ][25135] Syncing log_handlers for environment 'base'
2017-10-27 23:32:38,319 [salt.utils.extmods][INFO    ][25135] Loading cache from salt://_log_handlers, for base)
2017-10-27 23:32:38,319 [salt.fileclient  ][INFO    ][25135] Caching directory '_log_handlers/' for environment 'base'
2017-10-27 23:32:38,382 [salt.utils.extmods][INFO    ][25135] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-27 23:32:38,388 [salt.utils.extmods][INFO    ][25135] Syncing proxy for environment 'base'
2017-10-27 23:32:38,388 [salt.utils.extmods][INFO    ][25135] Loading cache from salt://_proxy, for base)
2017-10-27 23:32:38,389 [salt.fileclient  ][INFO    ][25135] Caching directory '_proxy/' for environment 'base'
2017-10-27 23:32:38,439 [salt.utils.extmods][INFO    ][25135] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-27 23:32:38,443 [salt.utils.extmods][INFO    ][25135] Syncing engines for environment 'base'
2017-10-27 23:32:38,443 [salt.utils.extmods][INFO    ][25135] Loading cache from salt://_engines, for base)
2017-10-27 23:32:38,443 [salt.fileclient  ][INFO    ][25135] Caching directory '_engines/' for environment 'base'
2017-10-27 23:32:38,500 [salt.minion      ][INFO    ][25135] Returning information for job: 20171027233231027488
2017-10-27 23:38:50,929 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command test.ping with jid 20171027233850917940
2017-10-27 23:38:50,960 [salt.minion      ][INFO    ][25328] Starting a new job with PID 25328
2017-10-27 23:38:51,011 [salt.minion      ][INFO    ][25328] Returning information for job: 20171027233850917940
2017-10-27 23:39:36,222 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command state.sls with jid 20171027233936207521
2017-10-27 23:39:36,243 [salt.minion      ][INFO    ][25341] Starting a new job with PID 25341
2017-10-27 23:39:38,427 [salt.state       ][INFO    ][25341] Loading fresh modules for state activity
2017-10-27 23:39:38,500 [salt.fileclient  ][INFO    ][25341] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-27 23:39:38,529 [salt.fileclient  ][INFO    ][25341] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-27 23:39:38,580 [salt.fileclient  ][INFO    ][25341] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 23:39:38,948 [salt.state       ][INFO    ][25341] Running state [lsof] at time 23:39:38.947767
2017-10-27 23:39:38,948 [salt.state       ][INFO    ][25341] Executing state pkg.installed for lsof
2017-10-27 23:39:38,948 [salt.loaded.int.module.cmdmod][INFO    ][25341] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 23:39:39,263 [salt.state       ][INFO    ][25341] Package lsof is already installed
2017-10-27 23:39:39,263 [salt.state       ][INFO    ][25341] Completed state [lsof] at time 23:39:39.263218 duration_in_ms=315.45
2017-10-27 23:39:39,264 [salt.state       ][INFO    ][25341] Running state [keepalived] at time 23:39:39.263821
2017-10-27 23:39:39,264 [salt.state       ][INFO    ][25341] Executing state pkg.installed for keepalived
2017-10-27 23:39:39,289 [salt.loaded.int.module.cmdmod][INFO    ][25341] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-27 23:39:42,003 [salt.loaded.int.module.cmdmod][INFO    ][25341] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-10-27 23:39:46,274 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027233946258988
2017-10-27 23:39:46,297 [salt.minion      ][INFO    ][26838] Starting a new job with PID 26838
2017-10-27 23:39:46,315 [salt.minion      ][INFO    ][26838] Returning information for job: 20171027233946258988
2017-10-27 23:39:46,335 [salt.loaded.int.module.cmdmod][INFO    ][25341] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 23:39:46,394 [salt.state       ][INFO    ][25341] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-10-27 23:39:46,410 [salt.state       ][INFO    ][25341] Loading fresh modules for state activity
2017-10-27 23:39:46,429 [salt.state       ][INFO    ][25341] Completed state [keepalived] at time 23:39:46.429323 duration_in_ms=7165.5
2017-10-27 23:39:46,431 [salt.state       ][INFO    ][25341] Running state [/etc/keepalived/keepalived.conf] at time 23:39:46.431354
2017-10-27 23:39:46,432 [salt.state       ][INFO    ][25341] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-27 23:39:46,467 [salt.fileclient  ][INFO    ][25341] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-27 23:39:46,519 [salt.fileclient  ][INFO    ][25341] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 23:39:46,535 [salt.state       ][INFO    ][25341] File changed:
New file
2017-10-27 23:39:46,535 [salt.state       ][INFO    ][25341] Completed state [/etc/keepalived/keepalived.conf] at time 23:39:46.534731 duration_in_ms=103.376
2017-10-27 23:39:46,642 [salt.state       ][INFO    ][25341] Running state [keepalived] at time 23:39:46.641656
2017-10-27 23:39:46,642 [salt.state       ][INFO    ][25341] Executing state service.running for keepalived
2017-10-27 23:39:46,644 [salt.loaded.int.module.cmdmod][INFO    ][25341] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-27 23:39:46,664 [salt.loaded.int.module.cmdmod][INFO    ][25341] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 23:39:46,683 [salt.loaded.int.module.cmdmod][INFO    ][25341] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 23:39:46,705 [salt.loaded.int.module.cmdmod][INFO    ][25341] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 23:39:46,726 [salt.loaded.int.module.cmdmod][INFO    ][25341] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-10-27 23:39:46,801 [salt.loaded.int.module.cmdmod][INFO    ][25341] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 23:39:46,821 [salt.loaded.int.module.cmdmod][INFO    ][25341] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 23:39:46,844 [salt.loaded.int.module.cmdmod][INFO    ][25341] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 23:39:46,862 [salt.state       ][INFO    ][25341] {'keepalived': True}
2017-10-27 23:39:46,863 [salt.state       ][INFO    ][25341] Completed state [keepalived] at time 23:39:46.862697 duration_in_ms=221.041
2017-10-27 23:39:46,865 [salt.minion      ][INFO    ][25341] Returning information for job: 20171027233936207521
2017-10-27 23:41:01,878 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command pillar.get with jid 20171027234101865138
2017-10-27 23:41:01,907 [salt.minion      ][INFO    ][26952] Starting a new job with PID 26952
2017-10-27 23:41:01,911 [salt.minion      ][INFO    ][26952] Returning information for job: 20171027234101865138
2017-10-27 23:45:42,260 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command state.sls with jid 20171027234542248376
2017-10-27 23:45:42,287 [salt.minion      ][INFO    ][27043] Starting a new job with PID 27043
2017-10-27 23:45:44,968 [salt.state       ][INFO    ][27043] Loading fresh modules for state activity
2017-10-27 23:45:45,008 [salt.fileclient  ][INFO    ][27043] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 23:45:45,044 [salt.fileclient  ][INFO    ][27043] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 23:45:45,395 [salt.state       ][INFO    ][27043] Running state [attr] at time 23:45:45.395399
2017-10-27 23:45:45,396 [salt.state       ][INFO    ][27043] Executing state pkg.installed for attr
2017-10-27 23:45:45,396 [salt.loaded.int.module.cmdmod][INFO    ][27043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 23:45:45,752 [salt.loaded.int.module.cmdmod][INFO    ][27043] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-27 23:45:48,342 [salt.loaded.int.module.cmdmod][INFO    ][27043] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-10-27 23:45:50,542 [salt.loaded.int.module.cmdmod][INFO    ][27043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 23:45:50,598 [salt.state       ][INFO    ][27043] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-10-27 23:45:50,640 [salt.state       ][INFO    ][27043] Loading fresh modules for state activity
2017-10-27 23:45:50,664 [salt.state       ][INFO    ][27043] Completed state [attr] at time 23:45:50.664431 duration_in_ms=5269.032
2017-10-27 23:45:50,670 [salt.state       ][INFO    ][27043] Running state [glusterfs-server] at time 23:45:50.670268
2017-10-27 23:45:50,671 [salt.state       ][INFO    ][27043] Executing state pkg.installed for glusterfs-server
2017-10-27 23:45:50,985 [salt.loaded.int.module.cmdmod][INFO    ][27043] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-10-27 23:45:52,369 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027234552346565
2017-10-27 23:45:52,394 [salt.minion      ][INFO    ][28050] Starting a new job with PID 28050
2017-10-27 23:45:52,411 [salt.minion      ][INFO    ][28050] Returning information for job: 20171027234552346565
2017-10-27 23:46:02,387 [salt.loaded.int.module.cmdmod][INFO    ][27043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 23:46:02,445 [salt.state       ][INFO    ][27043] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-10-27 23:46:02,475 [salt.state       ][INFO    ][27043] Loading fresh modules for state activity
2017-10-27 23:46:02,494 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027234602480111
2017-10-27 23:46:02,502 [salt.state       ][INFO    ][27043] Completed state [glusterfs-server] at time 23:46:02.502440 duration_in_ms=11832.171
2017-10-27 23:46:02,511 [salt.minion      ][INFO    ][31357] Starting a new job with PID 31357
2017-10-27 23:46:02,513 [salt.state       ][INFO    ][27043] Running state [bc] at time 23:46:02.512736
2017-10-27 23:46:02,513 [salt.state       ][INFO    ][27043] Executing state pkg.installed for bc
2017-10-27 23:46:02,526 [salt.minion      ][INFO    ][31357] Returning information for job: 20171027234602480111
2017-10-27 23:46:02,874 [salt.loaded.int.module.cmdmod][INFO    ][27043] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-10-27 23:46:04,918 [salt.loaded.int.module.cmdmod][INFO    ][27043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 23:46:04,985 [salt.state       ][INFO    ][27043] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-10-27 23:46:05,018 [salt.state       ][INFO    ][27043] Loading fresh modules for state activity
2017-10-27 23:46:05,044 [salt.state       ][INFO    ][27043] Completed state [bc] at time 23:46:05.044257 duration_in_ms=2531.521
2017-10-27 23:46:05,145 [salt.state       ][INFO    ][27043] Running state [glusterfs-server] at time 23:46:05.144756
2017-10-27 23:46:05,145 [salt.state       ][INFO    ][27043] Executing state service.running for glusterfs-server
2017-10-27 23:46:05,147 [salt.loaded.int.module.cmdmod][INFO    ][27043] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 23:46:05,165 [salt.loaded.int.module.cmdmod][INFO    ][27043] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 23:46:05,185 [salt.loaded.int.module.cmdmod][INFO    ][27043] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 23:46:05,207 [salt.state       ][INFO    ][27043] The service glusterfs-server is already running
2017-10-27 23:46:05,208 [salt.state       ][INFO    ][27043] Completed state [glusterfs-server] at time 23:46:05.207516 duration_in_ms=62.772
2017-10-27 23:46:05,212 [salt.state       ][INFO    ][27043] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:46:05.211512
2017-10-27 23:46:05,214 [salt.state       ][INFO    ][27043] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 23:46:05,221 [salt.state       ][INFO    ][27043] File changed:
New file
2017-10-27 23:46:05,221 [salt.state       ][INFO    ][27043] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:46:05.221390 duration_in_ms=9.879
2017-10-27 23:46:05,222 [salt.state       ][INFO    ][27043] Running state [/srv/glusterfs/glance] at time 23:46:05.221613
2017-10-27 23:46:05,222 [salt.state       ][INFO    ][27043] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 23:46:05,223 [salt.state       ][INFO    ][27043] {'/srv/glusterfs/glance': 'New Dir'}
2017-10-27 23:46:05,223 [salt.state       ][INFO    ][27043] Completed state [/srv/glusterfs/glance] at time 23:46:05.223035 duration_in_ms=1.422
2017-10-27 23:46:05,223 [salt.state       ][INFO    ][27043] Running state [/srv/glusterfs/keystone-keys] at time 23:46:05.223243
2017-10-27 23:46:05,223 [salt.state       ][INFO    ][27043] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 23:46:05,225 [salt.state       ][INFO    ][27043] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-10-27 23:46:05,226 [salt.state       ][INFO    ][27043] Completed state [/srv/glusterfs/keystone-keys] at time 23:46:05.225491 duration_in_ms=2.248
2017-10-27 23:46:05,226 [salt.state       ][INFO    ][27043] Running state [/srv/glusterfs/nova_instances] at time 23:46:05.225674
2017-10-27 23:46:05,226 [salt.state       ][INFO    ][27043] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 23:46:05,227 [salt.state       ][INFO    ][27043] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-10-27 23:46:05,227 [salt.state       ][INFO    ][27043] Completed state [/srv/glusterfs/nova_instances] at time 23:46:05.226829 duration_in_ms=1.155
2017-10-27 23:46:05,227 [salt.state       ][INFO    ][27043] Running state [/srv/glusterfs/keystone-credential-keys] at time 23:46:05.227018
2017-10-27 23:46:05,227 [salt.state       ][INFO    ][27043] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 23:46:05,228 [salt.state       ][INFO    ][27043] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-10-27 23:46:05,228 [salt.state       ][INFO    ][27043] Completed state [/srv/glusterfs/keystone-credential-keys] at time 23:46:05.228153 duration_in_ms=1.135
2017-10-27 23:46:05,229 [salt.minion      ][INFO    ][27043] Returning information for job: 20171027234542248376
2017-10-27 23:46:07,039 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command test.ping with jid 20171027234607027397
2017-10-27 23:46:07,063 [salt.minion      ][INFO    ][31816] Starting a new job with PID 31816
2017-10-27 23:46:07,105 [salt.minion      ][INFO    ][31816] Returning information for job: 20171027234607027397
2017-10-27 23:46:31,677 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command state.sls with jid 20171027234631661766
2017-10-27 23:46:31,703 [salt.minion      ][INFO    ][32028] Starting a new job with PID 32028
2017-10-27 23:46:33,854 [salt.state       ][INFO    ][32028] Loading fresh modules for state activity
2017-10-27 23:46:33,901 [salt.fileclient  ][INFO    ][32028] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-27 23:46:33,958 [salt.fileclient  ][INFO    ][32028] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 23:46:34,050 [salt.fileclient  ][INFO    ][32028] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 23:46:34,090 [salt.fileclient  ][INFO    ][32028] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 23:46:34,452 [salt.state       ][INFO    ][32028] Running state [attr] at time 23:46:34.452359
2017-10-27 23:46:34,453 [salt.state       ][INFO    ][32028] Executing state pkg.installed for attr
2017-10-27 23:46:34,453 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 23:46:34,782 [salt.state       ][INFO    ][32028] Package attr is already installed
2017-10-27 23:46:34,782 [salt.state       ][INFO    ][32028] Completed state [attr] at time 23:46:34.782093 duration_in_ms=329.733
2017-10-27 23:46:34,782 [salt.state       ][INFO    ][32028] Running state [glusterfs-server] at time 23:46:34.782326
2017-10-27 23:46:34,783 [salt.state       ][INFO    ][32028] Executing state pkg.installed for glusterfs-server
2017-10-27 23:46:34,786 [salt.state       ][INFO    ][32028] Package glusterfs-server is already installed
2017-10-27 23:46:34,786 [salt.state       ][INFO    ][32028] Completed state [glusterfs-server] at time 23:46:34.786238 duration_in_ms=3.911
2017-10-27 23:46:34,786 [salt.state       ][INFO    ][32028] Running state [bc] at time 23:46:34.786411
2017-10-27 23:46:34,787 [salt.state       ][INFO    ][32028] Executing state pkg.installed for bc
2017-10-27 23:46:34,790 [salt.state       ][INFO    ][32028] Package bc is already installed
2017-10-27 23:46:34,790 [salt.state       ][INFO    ][32028] Completed state [bc] at time 23:46:34.790265 duration_in_ms=3.854
2017-10-27 23:46:34,791 [salt.state       ][INFO    ][32028] Running state [glusterfs-server] at time 23:46:34.791241
2017-10-27 23:46:34,791 [salt.state       ][INFO    ][32028] Executing state service.running for glusterfs-server
2017-10-27 23:46:34,792 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 23:46:34,811 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-10-27 23:46:34,903 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 23:46:34,947 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 23:46:34,963 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 23:46:34,985 [salt.state       ][INFO    ][32028] The service glusterfs-server is already running
2017-10-27 23:46:34,985 [salt.state       ][INFO    ][32028] Completed state [glusterfs-server] at time 23:46:34.984832 duration_in_ms=193.59
2017-10-27 23:46:34,987 [salt.state       ][INFO    ][32028] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:46:34.987200
2017-10-27 23:46:34,988 [salt.state       ][INFO    ][32028] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 23:46:34,994 [salt.state       ][INFO    ][32028] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-27 23:46:34,994 [salt.state       ][INFO    ][32028] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:46:34.993861 duration_in_ms=6.66
2017-10-27 23:46:34,995 [salt.state       ][INFO    ][32028] Running state [/srv/glusterfs/glance] at time 23:46:34.995086
2017-10-27 23:46:34,995 [salt.state       ][INFO    ][32028] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 23:46:34,997 [salt.state       ][INFO    ][32028] Directory /srv/glusterfs/glance is in the correct state
2017-10-27 23:46:34,997 [salt.state       ][INFO    ][32028] Completed state [/srv/glusterfs/glance] at time 23:46:34.996727 duration_in_ms=1.641
2017-10-27 23:46:34,997 [salt.state       ][INFO    ][32028] Running state [/srv/glusterfs/keystone-keys] at time 23:46:34.997048
2017-10-27 23:46:34,997 [salt.state       ][INFO    ][32028] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 23:46:34,998 [salt.state       ][INFO    ][32028] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-27 23:46:34,998 [salt.state       ][INFO    ][32028] Completed state [/srv/glusterfs/keystone-keys] at time 23:46:34.998322 duration_in_ms=1.274
2017-10-27 23:46:34,999 [salt.state       ][INFO    ][32028] Running state [/srv/glusterfs/nova_instances] at time 23:46:34.998640
2017-10-27 23:46:34,999 [salt.state       ][INFO    ][32028] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 23:46:34,1000 [salt.state       ][INFO    ][32028] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-27 23:46:35,001 [salt.state       ][INFO    ][32028] Completed state [/srv/glusterfs/nova_instances] at time 23:46:35.000739 duration_in_ms=2.1
2017-10-27 23:46:35,001 [salt.state       ][INFO    ][32028] Running state [/srv/glusterfs/keystone-credential-keys] at time 23:46:35.000940
2017-10-27 23:46:35,001 [salt.state       ][INFO    ][32028] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 23:46:35,002 [salt.state       ][INFO    ][32028] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-27 23:46:35,002 [salt.state       ][INFO    ][32028] Completed state [/srv/glusterfs/keystone-credential-keys] at time 23:46:35.001654 duration_in_ms=0.714
2017-10-27 23:46:35,076 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command ['git', '--version'] in directory '/root'
2017-10-27 23:46:35,146 [salt.state       ][INFO    ][32028] Running state [sleep 5] at time 23:46:35.145829
2017-10-27 23:46:35,146 [salt.state       ][INFO    ][32028] Executing state cmd.wait for sleep 5
2017-10-27 23:46:35,147 [salt.state       ][INFO    ][32028] No changes made for sleep 5
2017-10-27 23:46:35,147 [salt.state       ][INFO    ][32028] Completed state [sleep 5] at time 23:46:35.147015 duration_in_ms=1.186
2017-10-27 23:46:35,148 [salt.state       ][INFO    ][32028] Running state [192.168.10.143] at time 23:46:35.147601
2017-10-27 23:46:35,148 [salt.state       ][INFO    ][32028] Executing state glusterfs.peered for 192.168.10.143
2017-10-27 23:46:35,148 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:35,163 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:35,245 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:35,265 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:35,349 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:35,367 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:35,444 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:35,462 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:35,619 [salt.state       ][INFO    ][32028] {'new': {'192.168.10.141': [], 'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': ['192.168.10.143']}, 'old': {'192.168.10.141': [], 'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': []}}
2017-10-27 23:46:35,620 [salt.state       ][INFO    ][32028] Completed state [192.168.10.143] at time 23:46:35.620146 duration_in_ms=472.544
2017-10-27 23:46:35,624 [salt.state       ][INFO    ][32028] Running state [192.168.10.142] at time 23:46:35.623663
2017-10-27 23:46:35,624 [salt.state       ][INFO    ][32028] Executing state glusterfs.peered for 192.168.10.142
2017-10-27 23:46:35,624 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:35,642 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:35,722 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:35,741 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:35,832 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:35,854 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:35,933 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:35,953 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:36,037 [salt.state       ][INFO    ][32028] Peering with localhost is not needed
2017-10-27 23:46:36,037 [salt.state       ][INFO    ][32028] Completed state [192.168.10.142] at time 23:46:36.037286 duration_in_ms=413.621
2017-10-27 23:46:36,045 [salt.state       ][INFO    ][32028] Running state [192.168.10.141] at time 23:46:36.045331
2017-10-27 23:46:36,046 [salt.state       ][INFO    ][32028] Executing state glusterfs.peered for 192.168.10.141
2017-10-27 23:46:36,046 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:36,063 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:36,146 [salt.state       ][INFO    ][32028] Host 192.168.10.141 already peered
2017-10-27 23:46:36,147 [salt.state       ][INFO    ][32028] Completed state [192.168.10.141] at time 23:46:36.146959 duration_in_ms=101.626
2017-10-27 23:46:36,150 [salt.state       ][INFO    ][32028] Running state [glance] at time 23:46:36.150076
2017-10-27 23:46:36,151 [salt.state       ][INFO    ][32028] Executing state glusterfs.created for glance
2017-10-27 23:46:36,152 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:36,171 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:36,253 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:36,272 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:36,362 [salt.state       ][INFO    ][32028] Volume glance already exists and is started.
2017-10-27 23:46:36,363 [salt.state       ][INFO    ][32028] Completed state [glance] at time 23:46:36.362604 duration_in_ms=212.528
2017-10-27 23:46:36,371 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 23:46:36.371413
2017-10-27 23:46:36,372 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 23:46:36,373 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 23:46:36,467 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:36,467 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 23:46:36.467367 duration_in_ms=95.952
2017-10-27 23:46:36,470 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 23:46:36.469555
2017-10-27 23:46:36,471 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-27 23:46:36,474 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 23:46:36,575 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:36,577 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 23:46:36.576695 duration_in_ms=107.14
2017-10-27 23:46:36,578 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 23:46:36.577935
2017-10-27 23:46:36,578 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-27 23:46:36,579 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 23:46:36,670 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:36,670 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 23:46:36.670194 duration_in_ms=92.257
2017-10-27 23:46:36,671 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 23:46:36.671303
2017-10-27 23:46:36,673 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 23:46:36,674 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 23:46:36,766 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:36,766 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 23:46:36.766375 duration_in_ms=95.072
2017-10-27 23:46:36,768 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 23:46:36.767726
2017-10-27 23:46:36,769 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-27 23:46:36,770 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 23:46:36,852 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:36,853 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 23:46:36.852684 duration_in_ms=84.957
2017-10-27 23:46:36,857 [salt.state       ][INFO    ][32028] Running state [glance] at time 23:46:36.856557
2017-10-27 23:46:36,857 [salt.state       ][INFO    ][32028] Executing state glusterfs.started for glance
2017-10-27 23:46:36,858 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:36,879 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:36,973 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:36,993 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:37,077 [salt.state       ][INFO    ][32028] Volume glance is already started
2017-10-27 23:46:37,078 [salt.state       ][INFO    ][32028] Completed state [glance] at time 23:46:37.078164 duration_in_ms=221.606
2017-10-27 23:46:37,081 [salt.state       ][INFO    ][32028] Running state [keystone-keys] at time 23:46:37.080930
2017-10-27 23:46:37,081 [salt.state       ][INFO    ][32028] Executing state glusterfs.created for keystone-keys
2017-10-27 23:46:37,082 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:37,098 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:37,175 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:37,195 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:37,285 [salt.state       ][INFO    ][32028] Volume keystone-keys already exists and is started.
2017-10-27 23:46:37,286 [salt.state       ][INFO    ][32028] Completed state [keystone-keys] at time 23:46:37.285777 duration_in_ms=204.847
2017-10-27 23:46:37,296 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 23:46:37.295713
2017-10-27 23:46:37,297 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-27 23:46:37,297 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 23:46:37,387 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:37,387 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 23:46:37.387319 duration_in_ms=91.605
2017-10-27 23:46:37,389 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:46:37.389129
2017-10-27 23:46:37,390 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 23:46:37,391 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 23:46:37,483 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:37,484 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:46:37.483587 duration_in_ms=94.458
2017-10-27 23:46:37,488 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:46:37.487452
2017-10-27 23:46:37,488 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 23:46:37,489 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 23:46:37,577 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:37,578 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:46:37.577470 duration_in_ms=90.018
2017-10-27 23:46:37,579 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 23:46:37.578570
2017-10-27 23:46:37,579 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-27 23:46:37,581 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 23:46:37,672 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:37,673 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 23:46:37.672747 duration_in_ms=94.177
2017-10-27 23:46:37,674 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 23:46:37.673935
2017-10-27 23:46:37,674 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 23:46:37,675 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 23:46:37,765 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:37,765 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 23:46:37.765371 duration_in_ms=91.427
2017-10-27 23:46:37,769 [salt.state       ][INFO    ][32028] Running state [keystone-keys] at time 23:46:37.769180
2017-10-27 23:46:37,770 [salt.state       ][INFO    ][32028] Executing state glusterfs.started for keystone-keys
2017-10-27 23:46:37,771 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:37,791 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:37,871 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:37,891 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:37,984 [salt.state       ][INFO    ][32028] Volume keystone-keys is already started
2017-10-27 23:46:37,985 [salt.state       ][INFO    ][32028] Completed state [keystone-keys] at time 23:46:37.984964 duration_in_ms=215.783
2017-10-27 23:46:37,988 [salt.state       ][INFO    ][32028] Running state [nova_instances] at time 23:46:37.987517
2017-10-27 23:46:37,989 [salt.state       ][INFO    ][32028] Executing state glusterfs.created for nova_instances
2017-10-27 23:46:37,990 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:38,014 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:38,098 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:38,117 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:38,210 [salt.state       ][INFO    ][32028] Volume nova_instances already exists and is started.
2017-10-27 23:46:38,211 [salt.state       ][INFO    ][32028] Completed state [nova_instances] at time 23:46:38.210544 duration_in_ms=223.026
2017-10-27 23:46:38,221 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 23:46:38.221036
2017-10-27 23:46:38,221 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 23:46:38,222 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 23:46:38,309 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:38,310 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 23:46:38.309604 duration_in_ms=88.566
2017-10-27 23:46:38,311 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 23:46:38.310913
2017-10-27 23:46:38,312 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-27 23:46:38,313 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-27 23:46:38,406 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:38,407 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 23:46:38.406674 duration_in_ms=95.761
2017-10-27 23:46:38,409 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 23:46:38.408483
2017-10-27 23:46:38,409 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-27 23:46:38,410 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-27 23:46:38,503 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:38,505 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 23:46:38.504780 duration_in_ms=96.296
2017-10-27 23:46:38,507 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 23:46:38.506572
2017-10-27 23:46:38,507 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-27 23:46:38,509 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-27 23:46:38,602 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:38,603 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 23:46:38.602491 duration_in_ms=95.919
2017-10-27 23:46:38,604 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 23:46:38.603614
2017-10-27 23:46:38,605 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 23:46:38,606 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 23:46:38,698 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:38,699 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 23:46:38.699134 duration_in_ms=95.519
2017-10-27 23:46:38,703 [salt.state       ][INFO    ][32028] Running state [nova_instances] at time 23:46:38.702826
2017-10-27 23:46:38,703 [salt.state       ][INFO    ][32028] Executing state glusterfs.started for nova_instances
2017-10-27 23:46:38,705 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:38,723 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:38,807 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:38,831 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:38,917 [salt.state       ][INFO    ][32028] Volume nova_instances is already started
2017-10-27 23:46:38,918 [salt.state       ][INFO    ][32028] Completed state [nova_instances] at time 23:46:38.917616 duration_in_ms=214.79
2017-10-27 23:46:38,922 [salt.state       ][INFO    ][32028] Running state [keystone-credential-keys] at time 23:46:38.921670
2017-10-27 23:46:38,922 [salt.state       ][INFO    ][32028] Executing state glusterfs.created for keystone-credential-keys
2017-10-27 23:46:38,923 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:38,939 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:39,019 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:39,039 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:39,131 [salt.state       ][INFO    ][32028] Volume keystone-credential-keys already exists and is started.
2017-10-27 23:46:39,132 [salt.state       ][INFO    ][32028] Completed state [keystone-credential-keys] at time 23:46:39.131642 duration_in_ms=209.971
2017-10-27 23:46:39,143 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 23:46:39.142941
2017-10-27 23:46:39,143 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 23:46:39,144 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 23:46:39,230 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:39,231 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 23:46:39.230951 duration_in_ms=88.008
2017-10-27 23:46:39,232 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:46:39.232316
2017-10-27 23:46:39,233 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 23:46:39,234 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 23:46:39,323 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:39,324 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:46:39.324206 duration_in_ms=91.889
2017-10-27 23:46:39,326 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 23:46:39.325706
2017-10-27 23:46:39,326 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-27 23:46:39,327 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 23:46:39,411 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:39,411 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 23:46:39.411059 duration_in_ms=85.352
2017-10-27 23:46:39,413 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:46:39.413123
2017-10-27 23:46:39,414 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 23:46:39,415 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 23:46:39,511 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:39,512 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:46:39.511561 duration_in_ms=98.437
2017-10-27 23:46:39,514 [salt.state       ][INFO    ][32028] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 23:46:39.513425
2017-10-27 23:46:39,514 [salt.state       ][INFO    ][32028] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-27 23:46:39,515 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 23:46:39,607 [salt.state       ][INFO    ][32028] unless execution succeeded
2017-10-27 23:46:39,607 [salt.state       ][INFO    ][32028] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 23:46:39.607208 duration_in_ms=93.782
2017-10-27 23:46:39,610 [salt.state       ][INFO    ][32028] Running state [keystone-credential-keys] at time 23:46:39.610368
2017-10-27 23:46:39,611 [salt.state       ][INFO    ][32028] Executing state glusterfs.started for keystone-credential-keys
2017-10-27 23:46:39,612 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:39,634 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:39,715 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:46:39,733 [salt.loaded.int.module.cmdmod][INFO    ][32028] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:46:39,826 [salt.state       ][INFO    ][32028] Volume keystone-credential-keys is already started
2017-10-27 23:46:39,827 [salt.state       ][INFO    ][32028] Completed state [keystone-credential-keys] at time 23:46:39.826389 duration_in_ms=216.02
2017-10-27 23:46:39,833 [salt.minion      ][INFO    ][32028] Returning information for job: 20171027234631661766
2017-10-27 23:46:45,084 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command test.ping with jid 20171027234645071418
2017-10-27 23:46:45,113 [salt.minion      ][INFO    ][32453] Starting a new job with PID 32453
2017-10-27 23:46:45,154 [salt.minion      ][INFO    ][32453] Returning information for job: 20171027234645071418
2017-10-27 23:46:45,543 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command cmd.run with jid 20171027234645525454
2017-10-27 23:46:45,566 [salt.minion      ][INFO    ][32459] Starting a new job with PID 32459
2017-10-27 23:46:45,577 [salt.loaded.int.module.cmdmod][INFO    ][32459] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-27 23:46:45,746 [salt.minion      ][INFO    ][32459] Returning information for job: 20171027234645525454
2017-10-28 00:27:56,868 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command test.ping with jid 20171028002756857571
2017-10-28 00:27:56,898 [salt.minion      ][INFO    ][33034] Starting a new job with PID 33034
2017-10-28 00:27:56,950 [salt.minion      ][INFO    ][33034] Returning information for job: 20171028002756857571
2017-10-28 00:28:10,326 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command state.sls with jid 20171028002810313429
2017-10-28 00:28:10,356 [salt.minion      ][INFO    ][33041] Starting a new job with PID 33041
2017-10-28 00:28:10,933 [salt.state       ][INFO    ][33041] Loading fresh modules for state activity
2017-10-28 00:28:10,968 [salt.fileclient  ][INFO    ][33041] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-28 00:28:10,999 [salt.fileclient  ][INFO    ][33041] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-28 00:28:11,038 [salt.fileclient  ][INFO    ][33041] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-28 00:28:11,429 [salt.state       ][INFO    ][33041] Running state [lsof] at time 00:28:11.428506
2017-10-28 00:28:11,429 [salt.state       ][INFO    ][33041] Executing state pkg.installed for lsof
2017-10-28 00:28:11,430 [salt.loaded.int.module.cmdmod][INFO    ][33041] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-28 00:28:11,806 [salt.state       ][INFO    ][33041] Package lsof is already installed
2017-10-28 00:28:11,807 [salt.state       ][INFO    ][33041] Completed state [lsof] at time 00:28:11.806463 duration_in_ms=377.957
2017-10-28 00:28:11,807 [salt.state       ][INFO    ][33041] Running state [keepalived] at time 00:28:11.806735
2017-10-28 00:28:11,807 [salt.state       ][INFO    ][33041] Executing state pkg.installed for keepalived
2017-10-28 00:28:11,812 [salt.state       ][INFO    ][33041] Package keepalived is already installed
2017-10-28 00:28:11,812 [salt.state       ][INFO    ][33041] Completed state [keepalived] at time 00:28:11.812347 duration_in_ms=5.612
2017-10-28 00:28:11,814 [salt.state       ][INFO    ][33041] Running state [/etc/keepalived/keepalived.conf] at time 00:28:11.813893
2017-10-28 00:28:11,814 [salt.state       ][INFO    ][33041] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-28 00:28:11,846 [salt.fileclient  ][INFO    ][33041] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-28 00:28:11,894 [salt.fileclient  ][INFO    ][33041] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-28 00:28:11,907 [salt.state       ][INFO    ][33041] File /etc/keepalived/keepalived.conf is in the correct state
2017-10-28 00:28:11,907 [salt.state       ][INFO    ][33041] Completed state [/etc/keepalived/keepalived.conf] at time 00:28:11.907180 duration_in_ms=93.287
2017-10-28 00:28:11,909 [salt.state       ][INFO    ][33041] Running state [keepalived] at time 00:28:11.908587
2017-10-28 00:28:11,909 [salt.state       ][INFO    ][33041] Executing state service.running for keepalived
2017-10-28 00:28:11,910 [salt.loaded.int.module.cmdmod][INFO    ][33041] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-28 00:28:11,950 [salt.loaded.int.module.cmdmod][INFO    ][33041] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-28 00:28:11,970 [salt.loaded.int.module.cmdmod][INFO    ][33041] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-28 00:28:11,995 [salt.state       ][INFO    ][33041] The service keepalived is already running
2017-10-28 00:28:11,996 [salt.state       ][INFO    ][33041] Completed state [keepalived] at time 00:28:11.995547 duration_in_ms=86.957
2017-10-28 00:28:12,001 [salt.minion      ][INFO    ][33041] Returning information for job: 20171028002810313429
2017-10-28 00:28:34,414 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command pillar.get with jid 20171028002834404535
2017-10-28 00:28:34,443 [salt.minion      ][INFO    ][33067] Starting a new job with PID 33067
2017-10-28 00:28:34,450 [salt.minion      ][INFO    ][33067] Returning information for job: 20171028002834404535
2017-10-28 00:29:24,470 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command state.sls with jid 20171028002924459672
2017-10-28 00:29:24,497 [salt.minion      ][INFO    ][33084] Starting a new job with PID 33084
2017-10-28 00:29:27,118 [salt.state       ][INFO    ][33084] Loading fresh modules for state activity
2017-10-28 00:29:27,158 [salt.fileclient  ][INFO    ][33084] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-28 00:29:27,195 [salt.fileclient  ][INFO    ][33084] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-28 00:29:27,590 [salt.state       ][INFO    ][33084] Running state [attr] at time 00:29:27.590279
2017-10-28 00:29:27,591 [salt.state       ][INFO    ][33084] Executing state pkg.installed for attr
2017-10-28 00:29:27,591 [salt.loaded.int.module.cmdmod][INFO    ][33084] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-28 00:29:27,973 [salt.state       ][INFO    ][33084] Package attr is already installed
2017-10-28 00:29:27,973 [salt.state       ][INFO    ][33084] Completed state [attr] at time 00:29:27.972767 duration_in_ms=382.489
2017-10-28 00:29:27,973 [salt.state       ][INFO    ][33084] Running state [glusterfs-server] at time 00:29:27.973002
2017-10-28 00:29:27,973 [salt.state       ][INFO    ][33084] Executing state pkg.installed for glusterfs-server
2017-10-28 00:29:27,979 [salt.state       ][INFO    ][33084] Package glusterfs-server is already installed
2017-10-28 00:29:27,979 [salt.state       ][INFO    ][33084] Completed state [glusterfs-server] at time 00:29:27.978737 duration_in_ms=5.736
2017-10-28 00:29:27,979 [salt.state       ][INFO    ][33084] Running state [bc] at time 00:29:27.978904
2017-10-28 00:29:27,979 [salt.state       ][INFO    ][33084] Executing state pkg.installed for bc
2017-10-28 00:29:27,983 [salt.state       ][INFO    ][33084] Package bc is already installed
2017-10-28 00:29:27,983 [salt.state       ][INFO    ][33084] Completed state [bc] at time 00:29:27.983446 duration_in_ms=4.542
2017-10-28 00:29:27,985 [salt.state       ][INFO    ][33084] Running state [glusterfs-server] at time 00:29:27.984589
2017-10-28 00:29:27,985 [salt.state       ][INFO    ][33084] Executing state service.running for glusterfs-server
2017-10-28 00:29:27,985 [salt.loaded.int.module.cmdmod][INFO    ][33084] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-28 00:29:28,021 [salt.loaded.int.module.cmdmod][INFO    ][33084] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-28 00:29:28,046 [salt.loaded.int.module.cmdmod][INFO    ][33084] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-28 00:29:28,078 [salt.state       ][INFO    ][33084] The service glusterfs-server is already running
2017-10-28 00:29:28,079 [salt.state       ][INFO    ][33084] Completed state [glusterfs-server] at time 00:29:28.078589 duration_in_ms=93.999
2017-10-28 00:29:28,087 [salt.state       ][INFO    ][33084] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 00:29:28.086730
2017-10-28 00:29:28,087 [salt.state       ][INFO    ][33084] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-28 00:29:28,090 [salt.state       ][INFO    ][33084] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-28 00:29:28,090 [salt.state       ][INFO    ][33084] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 00:29:28.089920 duration_in_ms=3.19
2017-10-28 00:29:28,090 [salt.state       ][INFO    ][33084] Running state [/srv/glusterfs/glance] at time 00:29:28.090096
2017-10-28 00:29:28,090 [salt.state       ][INFO    ][33084] Executing state file.directory for /srv/glusterfs/glance
2017-10-28 00:29:28,091 [salt.state       ][INFO    ][33084] Directory /srv/glusterfs/glance is in the correct state
2017-10-28 00:29:28,091 [salt.state       ][INFO    ][33084] Completed state [/srv/glusterfs/glance] at time 00:29:28.090799 duration_in_ms=0.703
2017-10-28 00:29:28,091 [salt.state       ][INFO    ][33084] Running state [/srv/glusterfs/keystone-keys] at time 00:29:28.090962
2017-10-28 00:29:28,091 [salt.state       ][INFO    ][33084] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-28 00:29:28,092 [salt.state       ][INFO    ][33084] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-28 00:29:28,092 [salt.state       ][INFO    ][33084] Completed state [/srv/glusterfs/keystone-keys] at time 00:29:28.091636 duration_in_ms=0.675
2017-10-28 00:29:28,094 [salt.state       ][INFO    ][33084] Running state [/srv/glusterfs/nova_instances] at time 00:29:28.094094
2017-10-28 00:29:28,094 [salt.state       ][INFO    ][33084] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-28 00:29:28,095 [salt.state       ][INFO    ][33084] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-28 00:29:28,095 [salt.state       ][INFO    ][33084] Completed state [/srv/glusterfs/nova_instances] at time 00:29:28.094793 duration_in_ms=0.699
2017-10-28 00:29:28,095 [salt.state       ][INFO    ][33084] Running state [/srv/glusterfs/keystone-credential-keys] at time 00:29:28.094955
2017-10-28 00:29:28,095 [salt.state       ][INFO    ][33084] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-28 00:29:28,097 [salt.state       ][INFO    ][33084] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-28 00:29:28,097 [salt.state       ][INFO    ][33084] Completed state [/srv/glusterfs/keystone-credential-keys] at time 00:29:28.097348 duration_in_ms=2.393
2017-10-28 00:29:28,098 [salt.minion      ][INFO    ][33084] Returning information for job: 20171028002924459672
2017-10-28 00:29:29,133 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command test.ping with jid 20171028002929120287
2017-10-28 00:29:29,156 [salt.minion      ][INFO    ][33107] Starting a new job with PID 33107
2017-10-28 00:29:29,207 [salt.minion      ][INFO    ][33107] Returning information for job: 20171028002929120287
2017-10-28 00:29:33,501 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command state.sls with jid 20171028002933487046
2017-10-28 00:29:33,527 [salt.minion      ][INFO    ][33112] Starting a new job with PID 33112
2017-10-28 00:29:34,133 [salt.state       ][INFO    ][33112] Loading fresh modules for state activity
2017-10-28 00:29:34,181 [salt.fileclient  ][INFO    ][33112] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-28 00:29:34,231 [salt.fileclient  ][INFO    ][33112] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-28 00:29:34,326 [salt.fileclient  ][INFO    ][33112] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-28 00:29:34,361 [salt.fileclient  ][INFO    ][33112] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-28 00:29:34,741 [salt.state       ][INFO    ][33112] Running state [attr] at time 00:29:34.740643
2017-10-28 00:29:34,741 [salt.state       ][INFO    ][33112] Executing state pkg.installed for attr
2017-10-28 00:29:34,742 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-28 00:29:35,137 [salt.state       ][INFO    ][33112] Package attr is already installed
2017-10-28 00:29:35,138 [salt.state       ][INFO    ][33112] Completed state [attr] at time 00:29:35.137495 duration_in_ms=396.851
2017-10-28 00:29:35,138 [salt.state       ][INFO    ][33112] Running state [glusterfs-server] at time 00:29:35.137761
2017-10-28 00:29:35,138 [salt.state       ][INFO    ][33112] Executing state pkg.installed for glusterfs-server
2017-10-28 00:29:35,142 [salt.state       ][INFO    ][33112] Package glusterfs-server is already installed
2017-10-28 00:29:35,142 [salt.state       ][INFO    ][33112] Completed state [glusterfs-server] at time 00:29:35.142104 duration_in_ms=4.342
2017-10-28 00:29:35,142 [salt.state       ][INFO    ][33112] Running state [bc] at time 00:29:35.142269
2017-10-28 00:29:35,142 [salt.state       ][INFO    ][33112] Executing state pkg.installed for bc
2017-10-28 00:29:35,146 [salt.state       ][INFO    ][33112] Package bc is already installed
2017-10-28 00:29:35,146 [salt.state       ][INFO    ][33112] Completed state [bc] at time 00:29:35.146201 duration_in_ms=3.932
2017-10-28 00:29:35,147 [salt.state       ][INFO    ][33112] Running state [glusterfs-server] at time 00:29:35.147127
2017-10-28 00:29:35,147 [salt.state       ][INFO    ][33112] Executing state service.running for glusterfs-server
2017-10-28 00:29:35,148 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-28 00:29:35,186 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-28 00:29:35,206 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-28 00:29:35,234 [salt.state       ][INFO    ][33112] The service glusterfs-server is already running
2017-10-28 00:29:35,234 [salt.state       ][INFO    ][33112] Completed state [glusterfs-server] at time 00:29:35.234046 duration_in_ms=86.918
2017-10-28 00:29:35,239 [salt.state       ][INFO    ][33112] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 00:29:35.239412
2017-10-28 00:29:35,241 [salt.state       ][INFO    ][33112] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-28 00:29:35,246 [salt.state       ][INFO    ][33112] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-28 00:29:35,247 [salt.state       ][INFO    ][33112] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 00:29:35.246440 duration_in_ms=7.028
2017-10-28 00:29:35,247 [salt.state       ][INFO    ][33112] Running state [/srv/glusterfs/glance] at time 00:29:35.246860
2017-10-28 00:29:35,247 [salt.state       ][INFO    ][33112] Executing state file.directory for /srv/glusterfs/glance
2017-10-28 00:29:35,249 [salt.state       ][INFO    ][33112] Directory /srv/glusterfs/glance is in the correct state
2017-10-28 00:29:35,250 [salt.state       ][INFO    ][33112] Completed state [/srv/glusterfs/glance] at time 00:29:35.249337 duration_in_ms=2.478
2017-10-28 00:29:35,251 [salt.state       ][INFO    ][33112] Running state [/srv/glusterfs/keystone-keys] at time 00:29:35.250646
2017-10-28 00:29:35,251 [salt.state       ][INFO    ][33112] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-28 00:29:35,251 [salt.state       ][INFO    ][33112] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-28 00:29:35,251 [salt.state       ][INFO    ][33112] Completed state [/srv/glusterfs/keystone-keys] at time 00:29:35.251459 duration_in_ms=0.814
2017-10-28 00:29:35,252 [salt.state       ][INFO    ][33112] Running state [/srv/glusterfs/nova_instances] at time 00:29:35.251647
2017-10-28 00:29:35,252 [salt.state       ][INFO    ][33112] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-28 00:29:35,253 [salt.state       ][INFO    ][33112] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-28 00:29:35,253 [salt.state       ][INFO    ][33112] Completed state [/srv/glusterfs/nova_instances] at time 00:29:35.253038 duration_in_ms=1.391
2017-10-28 00:29:35,253 [salt.state       ][INFO    ][33112] Running state [/srv/glusterfs/keystone-credential-keys] at time 00:29:35.253222
2017-10-28 00:29:35,253 [salt.state       ][INFO    ][33112] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-28 00:29:35,254 [salt.state       ][INFO    ][33112] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-28 00:29:35,254 [salt.state       ][INFO    ][33112] Completed state [/srv/glusterfs/keystone-credential-keys] at time 00:29:35.253970 duration_in_ms=0.748
2017-10-28 00:29:35,319 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command ['git', '--version'] in directory '/root'
2017-10-28 00:29:35,423 [salt.state       ][INFO    ][33112] Running state [sleep 5] at time 00:29:35.422588
2017-10-28 00:29:35,423 [salt.state       ][INFO    ][33112] Executing state cmd.wait for sleep 5
2017-10-28 00:29:35,423 [salt.state       ][INFO    ][33112] No changes made for sleep 5
2017-10-28 00:29:35,424 [salt.state       ][INFO    ][33112] Completed state [sleep 5] at time 00:29:35.423614 duration_in_ms=1.027
2017-10-28 00:29:35,425 [salt.state       ][INFO    ][33112] Running state [192.168.10.143] at time 00:29:35.424549
2017-10-28 00:29:35,425 [salt.state       ][INFO    ][33112] Executing state glusterfs.peered for 192.168.10.143
2017-10-28 00:29:35,425 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:35,439 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:35,523 [salt.state       ][INFO    ][33112] Host 192.168.10.143 already peered
2017-10-28 00:29:35,524 [salt.state       ][INFO    ][33112] Completed state [192.168.10.143] at time 00:29:35.523621 duration_in_ms=99.07
2017-10-28 00:29:35,534 [salt.state       ][INFO    ][33112] Running state [192.168.10.142] at time 00:29:35.533607
2017-10-28 00:29:35,534 [salt.state       ][INFO    ][33112] Executing state glusterfs.peered for 192.168.10.142
2017-10-28 00:29:35,535 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:35,554 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:35,641 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:35,661 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:35,756 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:35,780 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:35,867 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:35,891 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:35,978 [salt.state       ][INFO    ][33112] Peering with localhost is not needed
2017-10-28 00:29:35,979 [salt.state       ][INFO    ][33112] Completed state [192.168.10.142] at time 00:29:35.978474 duration_in_ms=444.865
2017-10-28 00:29:35,990 [salt.state       ][INFO    ][33112] Running state [192.168.10.141] at time 00:29:35.989634
2017-10-28 00:29:35,990 [salt.state       ][INFO    ][33112] Executing state glusterfs.peered for 192.168.10.141
2017-10-28 00:29:35,991 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:36,009 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:36,106 [salt.state       ][INFO    ][33112] Host 192.168.10.141 already peered
2017-10-28 00:29:36,107 [salt.state       ][INFO    ][33112] Completed state [192.168.10.141] at time 00:29:36.106689 duration_in_ms=117.053
2017-10-28 00:29:36,110 [salt.state       ][INFO    ][33112] Running state [glance] at time 00:29:36.109083
2017-10-28 00:29:36,110 [salt.state       ][INFO    ][33112] Executing state glusterfs.created for glance
2017-10-28 00:29:36,111 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:36,134 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:36,222 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:36,243 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:36,335 [salt.state       ][INFO    ][33112] Volume glance already exists and is started.
2017-10-28 00:29:36,336 [salt.state       ][INFO    ][33112] Completed state [glance] at time 00:29:36.335528 duration_in_ms=226.445
2017-10-28 00:29:36,346 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 00:29:36.345485
2017-10-28 00:29:36,346 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-28 00:29:36,346 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-28 00:29:36,443 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:36,444 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 00:29:36.443438 duration_in_ms=97.951
2017-10-28 00:29:36,445 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 00:29:36.445012
2017-10-28 00:29:36,446 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-28 00:29:36,447 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-28 00:29:36,558 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:36,558 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 00:29:36.558403 duration_in_ms=113.393
2017-10-28 00:29:36,560 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 00:29:36.560151
2017-10-28 00:29:36,560 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-28 00:29:36,561 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-28 00:29:36,662 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:36,663 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 00:29:36.663267 duration_in_ms=103.115
2017-10-28 00:29:36,665 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 00:29:36.665105
2017-10-28 00:29:36,666 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-28 00:29:36,667 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-28 00:29:36,763 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:36,763 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 00:29:36.763285 duration_in_ms=98.18
2017-10-28 00:29:36,766 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 00:29:36.765500
2017-10-28 00:29:36,766 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-28 00:29:36,767 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-28 00:29:36,858 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:36,858 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 00:29:36.857781 duration_in_ms=92.282
2017-10-28 00:29:36,863 [salt.state       ][INFO    ][33112] Running state [glance] at time 00:29:36.862576
2017-10-28 00:29:36,863 [salt.state       ][INFO    ][33112] Executing state glusterfs.started for glance
2017-10-28 00:29:36,864 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:36,885 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:36,977 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:36,1000 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:37,103 [salt.state       ][INFO    ][33112] Volume glance is already started
2017-10-28 00:29:37,104 [salt.state       ][INFO    ][33112] Completed state [glance] at time 00:29:37.104389 duration_in_ms=241.812
2017-10-28 00:29:37,107 [salt.state       ][INFO    ][33112] Running state [keystone-keys] at time 00:29:37.106692
2017-10-28 00:29:37,107 [salt.state       ][INFO    ][33112] Executing state glusterfs.created for keystone-keys
2017-10-28 00:29:37,112 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:37,134 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:37,221 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:37,242 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:37,341 [salt.state       ][INFO    ][33112] Volume keystone-keys already exists and is started.
2017-10-28 00:29:37,341 [salt.state       ][INFO    ][33112] Completed state [keystone-keys] at time 00:29:37.341019 duration_in_ms=234.326
2017-10-28 00:29:37,351 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 00:29:37.350547
2017-10-28 00:29:37,351 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-28 00:29:37,352 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-28 00:29:37,445 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:37,446 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 00:29:37.445895 duration_in_ms=95.346
2017-10-28 00:29:37,447 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 00:29:37.447126
2017-10-28 00:29:37,449 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-28 00:29:37,450 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-28 00:29:37,558 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:37,559 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 00:29:37.558637 duration_in_ms=111.51
2017-10-28 00:29:37,561 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 00:29:37.560462
2017-10-28 00:29:37,561 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-28 00:29:37,562 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-28 00:29:37,657 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:37,657 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 00:29:37.657069 duration_in_ms=96.607
2017-10-28 00:29:37,659 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 00:29:37.658880
2017-10-28 00:29:37,659 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-28 00:29:37,662 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-28 00:29:37,762 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:37,762 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 00:29:37.762064 duration_in_ms=103.184
2017-10-28 00:29:37,763 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 00:29:37.763338
2017-10-28 00:29:37,766 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-28 00:29:37,767 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-28 00:29:37,867 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:37,869 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 00:29:37.869370 duration_in_ms=106.031
2017-10-28 00:29:37,873 [salt.state       ][INFO    ][33112] Running state [keystone-keys] at time 00:29:37.873257
2017-10-28 00:29:37,874 [salt.state       ][INFO    ][33112] Executing state glusterfs.started for keystone-keys
2017-10-28 00:29:37,875 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:37,898 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:37,985 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:38,005 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:38,103 [salt.state       ][INFO    ][33112] Volume keystone-keys is already started
2017-10-28 00:29:38,105 [salt.state       ][INFO    ][33112] Completed state [keystone-keys] at time 00:29:38.104985 duration_in_ms=231.728
2017-10-28 00:29:38,107 [salt.state       ][INFO    ][33112] Running state [nova_instances] at time 00:29:38.107377
2017-10-28 00:29:38,110 [salt.state       ][INFO    ][33112] Executing state glusterfs.created for nova_instances
2017-10-28 00:29:38,110 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:38,131 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:38,220 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:38,242 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:38,335 [salt.state       ][INFO    ][33112] Volume nova_instances already exists and is started.
2017-10-28 00:29:38,337 [salt.state       ][INFO    ][33112] Completed state [nova_instances] at time 00:29:38.336724 duration_in_ms=229.347
2017-10-28 00:29:38,347 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 00:29:38.347014
2017-10-28 00:29:38,348 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-28 00:29:38,349 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-28 00:29:38,437 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:38,438 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 00:29:38.437905 duration_in_ms=90.889
2017-10-28 00:29:38,441 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 00:29:38.440439
2017-10-28 00:29:38,441 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-28 00:29:38,442 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-28 00:29:38,554 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:38,555 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 00:29:38.554736 duration_in_ms=114.296
2017-10-28 00:29:38,557 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 00:29:38.556900
2017-10-28 00:29:38,557 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-28 00:29:38,559 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-28 00:29:38,653 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:38,654 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 00:29:38.653603 duration_in_ms=96.703
2017-10-28 00:29:38,655 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 00:29:38.655049
2017-10-28 00:29:38,656 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-28 00:29:38,657 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-28 00:29:38,754 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:38,756 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 00:29:38.755483 duration_in_ms=100.434
2017-10-28 00:29:38,758 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 00:29:38.757056
2017-10-28 00:29:38,759 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-28 00:29:38,760 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-28 00:29:38,855 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:38,856 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 00:29:38.856080 duration_in_ms=99.024
2017-10-28 00:29:38,859 [salt.state       ][INFO    ][33112] Running state [nova_instances] at time 00:29:38.859006
2017-10-28 00:29:38,861 [salt.state       ][INFO    ][33112] Executing state glusterfs.started for nova_instances
2017-10-28 00:29:38,862 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:38,887 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:38,984 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:39,008 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:39,114 [salt.state       ][INFO    ][33112] Volume nova_instances is already started
2017-10-28 00:29:39,115 [salt.state       ][INFO    ][33112] Completed state [nova_instances] at time 00:29:39.114689 duration_in_ms=255.682
2017-10-28 00:29:39,119 [salt.state       ][INFO    ][33112] Running state [keystone-credential-keys] at time 00:29:39.118878
2017-10-28 00:29:39,119 [salt.state       ][INFO    ][33112] Executing state glusterfs.created for keystone-credential-keys
2017-10-28 00:29:39,120 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:39,143 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:39,229 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:39,250 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:39,341 [salt.state       ][INFO    ][33112] Volume keystone-credential-keys already exists and is started.
2017-10-28 00:29:39,342 [salt.state       ][INFO    ][33112] Completed state [keystone-credential-keys] at time 00:29:39.341709 duration_in_ms=222.829
2017-10-28 00:29:39,351 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 00:29:39.350981
2017-10-28 00:29:39,351 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-28 00:29:39,353 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-28 00:29:39,447 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:39,447 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 00:29:39.447164 duration_in_ms=96.181
2017-10-28 00:29:39,449 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 00:29:39.448933
2017-10-28 00:29:39,450 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-28 00:29:39,451 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-28 00:29:39,545 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:39,546 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 00:29:39.545762 duration_in_ms=96.829
2017-10-28 00:29:39,547 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 00:29:39.546989
2017-10-28 00:29:39,548 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-28 00:29:39,549 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-28 00:29:39,643 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:39,643 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 00:29:39.643407 duration_in_ms=96.417
2017-10-28 00:29:39,645 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 00:29:39.645161
2017-10-28 00:29:39,646 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-28 00:29:39,647 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-28 00:29:39,741 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:39,742 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 00:29:39.742343 duration_in_ms=97.182
2017-10-28 00:29:39,744 [salt.state       ][INFO    ][33112] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 00:29:39.743553
2017-10-28 00:29:39,745 [salt.state       ][INFO    ][33112] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-28 00:29:39,746 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-28 00:29:39,845 [salt.state       ][INFO    ][33112] unless execution succeeded
2017-10-28 00:29:39,846 [salt.state       ][INFO    ][33112] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 00:29:39.845695 duration_in_ms=102.142
2017-10-28 00:29:39,850 [salt.state       ][INFO    ][33112] Running state [keystone-credential-keys] at time 00:29:39.849616
2017-10-28 00:29:39,850 [salt.state       ][INFO    ][33112] Executing state glusterfs.started for keystone-credential-keys
2017-10-28 00:29:39,851 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:39,874 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:39,966 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --version' in directory '/root'
2017-10-28 00:29:39,989 [salt.loaded.int.module.cmdmod][INFO    ][33112] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-28 00:29:40,095 [salt.state       ][INFO    ][33112] Volume keystone-credential-keys is already started
2017-10-28 00:29:40,096 [salt.state       ][INFO    ][33112] Completed state [keystone-credential-keys] at time 00:29:40.095399 duration_in_ms=245.783
2017-10-28 00:29:40,101 [salt.minion      ][INFO    ][33112] Returning information for job: 20171028002933487046
2017-10-28 00:29:45,349 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command test.ping with jid 20171028002945339782
2017-10-28 00:29:45,379 [salt.minion      ][INFO    ][33495] Starting a new job with PID 33495
2017-10-28 00:29:45,429 [salt.minion      ][INFO    ][33495] Returning information for job: 20171028002945339782
2017-10-28 00:29:45,829 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command cmd.run with jid 20171028002945811813
2017-10-28 00:29:45,851 [salt.minion      ][INFO    ][33500] Starting a new job with PID 33500
2017-10-28 00:29:45,862 [salt.loaded.int.module.cmdmod][INFO    ][33500] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-28 00:29:46,067 [salt.minion      ][INFO    ][33500] Returning information for job: 20171028002945811813
2017-10-28 00:31:45,326 [salt.utils.schedule][INFO    ][24923] Running scheduled job: __mine_interval
2017-10-28 00:55:35,898 [salt.minion      ][INFO    ][24923] User sudo_ubuntu Executing command cp.push_dir with jid 20171028005535885010
2017-10-28 00:55:35,927 [salt.minion      ][INFO    ][33703] Starting a new job with PID 33703
