2017-09-25 15:29:59,936 [salt.cli.daemons ][WARNING ][2523] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-25 15:47:47,862 [salt.state       ][ERROR   ][3873] No contents found in top file
2017-09-25 15:48:06,363 [salt.utils.parsers][WARNING ][2523] Minion received a SIGTERM. Exiting.
2017-09-25 15:50:17,939 [salt.cli.daemons ][WARNING ][3297] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-25 15:50:51,946 [salt.loaded.int.module.cmdmod][ERROR   ][3415] Command '['apt-get', '-q', 'update']' failed with return code: 100
2017-09-25 15:50:51,947 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stdout: Get:1 http://apt-mk.mirantis.com/xenial nightly InRelease [23.5 kB]
Hit:2 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata InRelease
Hit:3 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security InRelease
Hit:4 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates InRelease
Hit:5 http://archive.ubuntu.com/ubuntu xenial InRelease
Get:6 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages [16.8 kB]
Hit:7 http://archive.ubuntu.com/ubuntu xenial-updates InRelease
Hit:8 http://archive.ubuntu.com/ubuntu xenial-backports InRelease
Err:6 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages
  Hash Sum mismatch
Hit:9 http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial InRelease
Hit:10 http://archive.ubuntu.com/ubuntu xenial-security InRelease
Fetched 40.3 kB in 0s (54.7 kB/s)
Reading package lists...
2017-09-25 15:50:51,947 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stderr: E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
2017-09-25 15:50:51,947 [salt.loaded.int.module.cmdmod][ERROR   ][3415] retcode: 100
2017-09-25 15:50:51,948 [salt.state       ][ERROR   ][3415] Failed to configure repo 'deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly ocata': E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
2017-09-25 15:50:54,853 [salt.loaded.int.module.cmdmod][ERROR   ][3415] Command '['apt-get', '-q', 'update']' failed with return code: 100
2017-09-25 15:50:54,853 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stdout: Get:1 http://apt-mk.mirantis.com/xenial nightly InRelease [23.5 kB]
Hit:2 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata InRelease
Get:3 http://apt-mk.mirantis.com/xenial nightly/extra amd64 Packages [37.3 kB]
Hit:4 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security InRelease
Get:5 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages [16.8 kB]
Err:5 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages
  Hash Sum mismatch
Hit:6 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates InRelease
Hit:7 http://archive.ubuntu.com/ubuntu xenial InRelease
Hit:8 http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial InRelease
Hit:9 http://archive.ubuntu.com/ubuntu xenial-updates InRelease
Hit:10 http://archive.ubuntu.com/ubuntu xenial-backports InRelease
Hit:11 http://archive.ubuntu.com/ubuntu xenial-security InRelease
Fetched 77.6 kB in 0s (104 kB/s)
Reading package lists...
2017-09-25 15:50:54,854 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stderr: E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
2017-09-25 15:50:54,854 [salt.loaded.int.module.cmdmod][ERROR   ][3415] retcode: 100
2017-09-25 15:50:54,854 [salt.state       ][ERROR   ][3415] Failed to configure repo 'deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly extra': E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
2017-09-25 15:50:57,862 [salt.loaded.int.module.cmdmod][ERROR   ][3415] Command '['apt-get', '-q', 'update']' failed with return code: 100
2017-09-25 15:50:57,863 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stdout: Get:1 http://apt-mk.mirantis.com/xenial nightly InRelease [23.5 kB]
Get:2 http://apt-mk.mirantis.com/xenial nightly/extra amd64 Packages [37.3 kB]
Get:3 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages [16.8 kB]
Err:3 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages
  Hash Sum mismatch
Hit:4 http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial InRelease
Hit:5 http://archive.ubuntu.com/ubuntu xenial InRelease
Hit:6 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata InRelease
Hit:7 http://archive.ubuntu.com/ubuntu xenial-updates InRelease
Get:8 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback InRelease [9974 B]
Hit:9 http://archive.ubuntu.com/ubuntu xenial-backports InRelease
Hit:10 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security InRelease
Hit:11 http://archive.ubuntu.com/ubuntu xenial-security InRelease
Hit:12 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates InRelease
Fetched 87.5 kB in 0s (101 kB/s)
Reading package lists...
2017-09-25 15:50:57,863 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stderr: E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
2017-09-25 15:50:57,863 [salt.loaded.int.module.cmdmod][ERROR   ][3415] retcode: 100
2017-09-25 15:50:57,863 [salt.state       ][ERROR   ][3415] Failed to configure repo 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback main': E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
2017-09-25 15:51:01,062 [salt.loaded.int.module.cmdmod][ERROR   ][3415] Command '['apt-get', '-q', 'update']' failed with return code: 100
2017-09-25 15:51:01,063 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stdout: Get:1 http://apt-mk.mirantis.com/xenial nightly InRelease [23.5 kB]
Get:2 http://apt-mk.mirantis.com/xenial nightly/extra amd64 Packages [37.3 kB]
Get:3 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages [16.8 kB]
Err:3 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages
  Hash Sum mismatch
Hit:4 http://archive.ubuntu.com/ubuntu xenial InRelease
Hit:5 http://archive.ubuntu.com/ubuntu xenial-updates InRelease
Hit:6 http://archive.ubuntu.com/ubuntu xenial-backports InRelease
Hit:7 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata InRelease
Hit:8 http://archive.ubuntu.com/ubuntu xenial-security InRelease
Hit:9 http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial InRelease
Hit:10 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback InRelease
Get:11 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-hotfix InRelease [9972 B]
Hit:12 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security InRelease
Hit:13 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates InRelease
Fetched 87.5 kB in 1s (84.5 kB/s)
Reading package lists...
2017-09-25 15:51:01,063 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stderr: E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
2017-09-25 15:51:01,063 [salt.loaded.int.module.cmdmod][ERROR   ][3415] retcode: 100
2017-09-25 15:51:01,063 [salt.state       ][ERROR   ][3415] Failed to configure repo 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-hotfix main': E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
2017-09-25 15:51:03,791 [salt.loaded.int.module.cmdmod][ERROR   ][3415] Command '['apt-get', '-q', 'update']' failed with return code: 100
2017-09-25 15:51:03,791 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stdout: Get:1 http://apt-mk.mirantis.com/xenial nightly InRelease [23.5 kB]
Hit:2 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata InRelease
Hit:3 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback InRelease
Get:4 http://apt-mk.mirantis.com/xenial nightly/extra amd64 Packages [37.3 kB]
Get:5 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages [16.8 kB]
Err:5 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages
  Hash Sum mismatch
Hit:6 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-hotfix InRelease
Hit:7 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security InRelease
Hit:8 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates InRelease
Hit:9 http://archive.ubuntu.com/ubuntu xenial InRelease
Hit:10 http://archive.ubuntu.com/ubuntu xenial-updates InRelease
Hit:11 http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial InRelease
Hit:12 http://archive.ubuntu.com/ubuntu xenial-backports InRelease
Hit:13 http://archive.ubuntu.com/ubuntu xenial-security InRelease
Fetched 77.6 kB in 0s (104 kB/s)
Reading package lists...
2017-09-25 15:51:03,791 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stderr: W: Target Packages (main/binary-amd64/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Translations (main/i18n/Translation-en) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
W: Target Packages (main/binary-amd64/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Translations (main/i18n/Translation-en) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
2017-09-25 15:51:03,791 [salt.loaded.int.module.cmdmod][ERROR   ][3415] retcode: 100
2017-09-25 15:51:03,792 [salt.state       ][ERROR   ][3415] Failed to configure repo 'deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial main': W: Target Packages (main/binary-amd64/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Translations (main/i18n/Translation-en) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
W: Target Packages (main/binary-amd64/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Translations (main/i18n/Translation-en) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
2017-09-25 15:51:08,076 [salt.loaded.int.module.cmdmod][ERROR   ][3415] Command '['apt-get', '-q', 'update']' failed with return code: 100
2017-09-25 15:51:08,076 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stdout: Get:1 http://apt-mk.mirantis.com/xenial nightly InRelease [23.5 kB]
Hit:2 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata InRelease
Get:3 http://apt-mk.mirantis.com/xenial nightly/extra amd64 Packages [37.3 kB]
Hit:4 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback InRelease
Get:5 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages [16.8 kB]
Err:5 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages
  Hash Sum mismatch
Hit:6 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-hotfix InRelease
Hit:7 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security InRelease
Hit:8 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates InRelease
Hit:9 http://archive.ubuntu.com/ubuntu xenial InRelease
Hit:10 http://archive.ubuntu.com/ubuntu xenial-updates InRelease
Hit:11 http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial InRelease
Hit:12 http://archive.ubuntu.com/ubuntu xenial-backports InRelease
Hit:13 http://archive.ubuntu.com/ubuntu xenial-security InRelease
Fetched 77.6 kB in 0s (169 kB/s)
Reading package lists...
2017-09-25 15:51:08,076 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stderr: W: Target Packages (main/binary-amd64/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Translations (main/i18n/Translation-en) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
W: Target Packages (main/binary-amd64/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Translations (main/i18n/Translation-en) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
2017-09-25 15:51:08,077 [salt.loaded.int.module.cmdmod][ERROR   ][3415] retcode: 100
2017-09-25 15:51:08,077 [salt.state       ][ERROR   ][3415] An error was encountered while checking the newest available version of package(s): W: Target Packages (main/binary-amd64/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Translations (main/i18n/Translation-en) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
W: Target Packages (main/binary-amd64/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Translations (main/i18n/Translation-en) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
2017-09-25 15:51:10,391 [salt.loaded.int.module.cmdmod][ERROR   ][3415] Command '['apt-get', '-q', 'update']' failed with return code: 100
2017-09-25 15:51:10,391 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stdout: Get:1 http://apt-mk.mirantis.com/xenial nightly InRelease [23.5 kB]
Hit:2 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata InRelease
Get:3 http://apt-mk.mirantis.com/xenial nightly/extra amd64 Packages [37.3 kB]
Hit:4 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback InRelease
Get:5 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages [16.8 kB]
Err:5 http://apt-mk.mirantis.com/xenial nightly/ocata amd64 Packages
  Hash Sum mismatch
Hit:6 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-hotfix InRelease
Hit:7 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security InRelease
Hit:8 http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates InRelease
Hit:9 http://archive.ubuntu.com/ubuntu xenial InRelease
Hit:10 http://archive.ubuntu.com/ubuntu xenial-updates InRelease
Hit:11 http://archive.ubuntu.com/ubuntu xenial-backports InRelease
Hit:12 http://archive.ubuntu.com/ubuntu xenial-security InRelease
Hit:13 http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial InRelease
Fetched 77.6 kB in 0s (172 kB/s)
Reading package lists...
2017-09-25 15:51:10,391 [salt.loaded.int.module.cmdmod][ERROR   ][3415] stderr: W: Target Packages (main/binary-amd64/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Translations (main/i18n/Translation-en) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
W: Target Packages (main/binary-amd64/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Translations (main/i18n/Translation-en) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
2017-09-25 15:51:10,392 [salt.loaded.int.module.cmdmod][ERROR   ][3415] retcode: 100
2017-09-25 15:51:10,392 [salt.state       ][ERROR   ][3415] An error was encountered while installing package(s): W: Target Packages (main/binary-amd64/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Translations (main/i18n/Translation-en) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
E: Failed to fetch http://apt-mk.mirantis.com/xenial/dists/nightly/ocata/binary-amd64/Packages.bz2  Hash Sum mismatch
E: Some index files failed to download. They have been ignored, or old ones used instead.
W: Target Packages (main/binary-amd64/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Packages (main/binary-all/Packages) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
W: Target Translations (main/i18n/Translation-en) is configured multiple times in /etc/apt/sources.list:50 and /etc/apt/sources.list.d/salt.list:1
2017-09-25 15:53:08,869 [salt.loaded.int.module.cmdmod][ERROR   ][9580] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-09-25 15:53:08,869 [salt.loaded.int.module.cmdmod][ERROR   ][9580] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-09-25 15:53:08,870 [salt.loaded.int.module.cmdmod][ERROR   ][9580] retcode: 1
2017-09-25 15:53:08,870 [salt.state       ][ERROR   ][9580] {'pid': 14348, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-09-25 15:53:14,625 [py.warnings      ][WARNING ][14394] /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-09-25 15:54:22,474 [salt.loaded.int.module.cmdmod][ERROR   ][14394] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 15:54:22,475 [salt.loaded.int.module.cmdmod][ERROR   ][14394] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 15:54:30,354 [salt.loaded.int.module.cmdmod][ERROR   ][14394] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 15:54:30,354 [salt.loaded.int.module.cmdmod][ERROR   ][14394] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 15:54:38,540 [salt.loaded.int.module.cmdmod][ERROR   ][14394] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 15:54:38,541 [salt.loaded.int.module.cmdmod][ERROR   ][14394] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 15:54:49,408 [salt.loaded.int.module.cmdmod][ERROR   ][14394] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-25 15:54:49,409 [salt.loaded.int.module.cmdmod][ERROR   ][14394] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-25 15:54:56,991 [salt.loaded.int.module.cmdmod][ERROR   ][14394] 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-09-25 15:54:59,948 [salt.loaded.int.module.cmdmod][INFO    ][21704] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-25 15:54:59,962 [salt.loaded.int.module.cmdmod][INFO    ][21704] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-25 15:54:59,984 [salt.loaded.int.module.cmdmod][INFO    ][21704] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-25 15:55:00,001 [salt.utils.parsers][WARNING ][3297] Minion received a SIGTERM. Exiting.
2017-09-25 15:55:00,418 [salt.cli.daemons ][INFO    ][21780] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-ha.local"
2017-09-25 15:55:01,106 [salt.minion      ][INFO    ][21780] Creating minion process manager
2017-09-25 15:55:01,107 [salt.cli.daemons ][WARNING ][21780] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-25 15:55:01,107 [salt.cli.daemons ][INFO    ][21780] The Salt Minion is starting up
2017-09-25 15:55:01,107 [salt.minion      ][INFO    ][21780] Minion is starting as user 'root'
2017-09-25 15:55:01,107 [salt.utils.event ][INFO    ][21780] Starting pull socket on /var/run/salt/minion/minion_event_98ff1e569f_pull.ipc
2017-09-25 15:55:02,200 [salt.loaded.int.module.cmdmod][INFO    ][21780] Executing command ['date', '+%z'] in directory '/root'
2017-09-25 15:55:02,214 [salt.utils.schedule][INFO    ][21780] Updating job settings for scheduled job: __mine_interval
2017-09-25 15:55:02,216 [salt.minion      ][INFO    ][21780] Added mine.update to scheduler
2017-09-25 15:55:02,325 [salt.minion      ][INFO    ][21780] Minion is ready to receive requests!
2017-09-25 15:55:03,326 [salt.utils.schedule][INFO    ][21780] Running scheduled job: __mine_interval
2017-09-25 15:55:16,735 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170925155516725002
2017-09-25 15:55:16,757 [salt.minion      ][INFO    ][21882] Starting a new job with PID 21882
2017-09-25 15:55:19,300 [salt.state       ][INFO    ][21882] Loading fresh modules for state activity
2017-09-25 15:55:19,340 [salt.state       ][ERROR   ][21882] No contents found in top file
2017-09-25 15:55:19,341 [salt.utils.extmods][INFO    ][21882] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-25 15:55:19,346 [salt.utils.extmods][INFO    ][21882] Syncing beacons for environment 'base'
2017-09-25 15:55:19,359 [salt.utils.extmods][INFO    ][21882] Loading cache from salt://_beacons, for base)
2017-09-25 15:55:19,360 [salt.fileclient  ][INFO    ][21882] Caching directory '_beacons/' for environment 'base'
2017-09-25 15:55:19,410 [salt.utils.extmods][INFO    ][21882] Syncing modules for environment 'base'
2017-09-25 15:55:19,411 [salt.utils.extmods][INFO    ][21882] Loading cache from salt://_modules, for base)
2017-09-25 15:55:19,411 [salt.fileclient  ][INFO    ][21882] Caching directory '_modules/' for environment 'base'
2017-09-25 15:55:19,509 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-25 15:55:19,550 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-25 15:55:19,593 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-25 15:55:19,627 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-25 15:55:19,656 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-25 15:55:19,720 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-25 15:55:19,806 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-25 15:55:19,893 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-25 15:55:19,939 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-25 15:55:20,008 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-25 15:55:20,141 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-25 15:55:20,222 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-25 15:55:20,280 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-25 15:55:20,370 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-25 15:55:20,384 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-25 15:55:20,444 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-25 15:55:20,593 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-25 15:55:20,716 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-25 15:55:20,823 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-25 15:55:20,906 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-25 15:55:20,966 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-25 15:55:21,031 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-25 15:55:21,097 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-25 15:55:21,129 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-25 15:55:21,176 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-25 15:55:21,245 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-25 15:55:21,285 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-25 15:55:21,343 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-25 15:55:21,378 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-25 15:55:21,409 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-25 15:55:21,428 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-25 15:55:21,552 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-25 15:55:21,559 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-25 15:55:21,560 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-25 15:55:21,619 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-25 15:55:21,628 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-25 15:55:21,635 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-25 15:55:21,657 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-25 15:55:21,713 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-25 15:55:21,736 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-25 15:55:21,737 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-25 15:55:21,738 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-25 15:55:21,739 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-25 15:55:21,740 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-25 15:55:21,749 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-25 15:55:21,751 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-25 15:55:21,752 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-25 15:55:21,763 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-25 15:55:21,764 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-25 15:55:21,769 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-25 15:55:21,770 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-25 15:55:21,770 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-25 15:55:21,771 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-25 15:55:21,772 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-25 15:55:21,774 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-25 15:55:21,775 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-25 15:55:21,776 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-25 15:55:21,777 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-25 15:55:21,777 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-25 15:55:21,778 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-25 15:55:21,779 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-25 15:55:21,780 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-25 15:55:21,781 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-25 15:55:21,782 [salt.utils.extmods][INFO    ][21882] 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-09-25 15:55:21,783 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-25 15:55:21,784 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-25 15:55:21,794 [salt.utils.extmods][INFO    ][21882] Syncing states for environment 'base'
2017-09-25 15:55:21,794 [salt.utils.extmods][INFO    ][21882] Loading cache from salt://_states, for base)
2017-09-25 15:55:21,795 [salt.fileclient  ][INFO    ][21882] Caching directory '_states/' for environment 'base'
2017-09-25 15:55:21,841 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-25 15:55:21,878 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-25 15:55:21,920 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-25 15:55:21,956 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-25 15:55:22,016 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-25 15:55:22,063 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-25 15:55:22,114 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-25 15:55:22,138 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-25 15:55:22,174 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-25 15:55:22,188 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-25 15:55:22,232 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-25 15:55:22,279 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-25 15:55:22,298 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-25 15:55:22,331 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-25 15:55:22,351 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-25 15:55:22,364 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-25 15:55:22,418 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-25 15:55:22,456 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-25 15:55:22,487 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-25 15:55:22,539 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-25 15:55:22,563 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-25 15:55:22,604 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-25 15:55:22,629 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-25 15:55:22,661 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-25 15:55:22,694 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-25 15:55:22,774 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-25 15:55:22,805 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-25 15:55:22,846 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-25 15:55:22,893 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-25 15:55:22,900 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-25 15:55:22,900 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-25 15:55:22,901 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-25 15:55:22,902 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-25 15:55:22,902 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-25 15:55:22,903 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-25 15:55:22,903 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-25 15:55:22,904 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-25 15:55:22,904 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-25 15:55:22,905 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-25 15:55:22,905 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-25 15:55:22,906 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-25 15:55:22,907 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-25 15:55:22,907 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-25 15:55:22,908 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-25 15:55:22,908 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-25 15:55:22,909 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-25 15:55:22,909 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-25 15:55:22,910 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-25 15:55:22,910 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-25 15:55:22,911 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-25 15:55:22,911 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-25 15:55:22,912 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-25 15:55:22,912 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-25 15:55:22,913 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-25 15:55:22,913 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-25 15:55:22,914 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-25 15:55:22,914 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-25 15:55:22,915 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-25 15:55:22,915 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-25 15:55:22,919 [salt.utils.extmods][INFO    ][21882] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-25 15:55:22,925 [salt.utils.extmods][INFO    ][21882] Syncing sdb for environment 'base'
2017-09-25 15:55:22,932 [salt.utils.extmods][INFO    ][21882] Loading cache from salt://_sdb, for base)
2017-09-25 15:55:22,932 [salt.fileclient  ][INFO    ][21882] Caching directory '_sdb/' for environment 'base'
2017-09-25 15:55:22,979 [salt.utils.extmods][INFO    ][21882] Syncing grains for environment 'base'
2017-09-25 15:55:22,979 [salt.utils.extmods][INFO    ][21882] Loading cache from salt://_grains, for base)
2017-09-25 15:55:22,980 [salt.fileclient  ][INFO    ][21882] Caching directory '_grains/' for environment 'base'
2017-09-25 15:55:23,078 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-25 15:55:23,111 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-25 15:55:23,164 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-25 15:55:23,211 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-25 15:55:23,272 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-25 15:55:23,319 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-25 15:55:23,346 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-25 15:55:23,382 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-25 15:55:23,404 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-25 15:55:23,467 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-25 15:55:23,512 [salt.fileclient  ][INFO    ][21882] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-25 15:55:23,519 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-25 15:55:23,527 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-25 15:55:23,528 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-25 15:55:23,529 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-25 15:55:23,530 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-25 15:55:23,546 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-25 15:55:23,551 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-25 15:55:23,577 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-25 15:55:23,578 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-25 15:55:23,578 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-25 15:55:23,579 [salt.utils.extmods][INFO    ][21882] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-25 15:55:23,582 [salt.utils.extmods][INFO    ][21882] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-25 15:55:23,588 [salt.utils.extmods][INFO    ][21882] Syncing renderers for environment 'base'
2017-09-25 15:55:23,599 [salt.utils.extmods][INFO    ][21882] Loading cache from salt://_renderers, for base)
2017-09-25 15:55:23,599 [salt.fileclient  ][INFO    ][21882] Caching directory '_renderers/' for environment 'base'
2017-09-25 15:55:23,643 [salt.utils.extmods][INFO    ][21882] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-25 15:55:23,648 [salt.utils.extmods][INFO    ][21882] Syncing returners for environment 'base'
2017-09-25 15:55:23,649 [salt.utils.extmods][INFO    ][21882] Loading cache from salt://_returners, for base)
2017-09-25 15:55:23,649 [salt.fileclient  ][INFO    ][21882] Caching directory '_returners/' for environment 'base'
2017-09-25 15:55:23,692 [salt.utils.extmods][INFO    ][21882] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-25 15:55:23,698 [salt.utils.extmods][INFO    ][21882] Syncing output for environment 'base'
2017-09-25 15:55:23,698 [salt.utils.extmods][INFO    ][21882] Loading cache from salt://_output, for base)
2017-09-25 15:55:23,698 [salt.fileclient  ][INFO    ][21882] Caching directory '_output/' for environment 'base'
2017-09-25 15:55:23,742 [salt.utils.extmods][INFO    ][21882] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-25 15:55:23,747 [salt.utils.extmods][INFO    ][21882] Syncing utils for environment 'base'
2017-09-25 15:55:23,747 [salt.utils.extmods][INFO    ][21882] Loading cache from salt://_utils, for base)
2017-09-25 15:55:23,747 [salt.fileclient  ][INFO    ][21882] Caching directory '_utils/' for environment 'base'
2017-09-25 15:55:23,803 [salt.utils.extmods][INFO    ][21882] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-25 15:55:23,809 [salt.utils.extmods][INFO    ][21882] Syncing log_handlers for environment 'base'
2017-09-25 15:55:23,809 [salt.utils.extmods][INFO    ][21882] Loading cache from salt://_log_handlers, for base)
2017-09-25 15:55:23,810 [salt.fileclient  ][INFO    ][21882] Caching directory '_log_handlers/' for environment 'base'
2017-09-25 15:55:23,853 [salt.utils.extmods][INFO    ][21882] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-25 15:55:23,858 [salt.utils.extmods][INFO    ][21882] Syncing proxy for environment 'base'
2017-09-25 15:55:23,858 [salt.utils.extmods][INFO    ][21882] Loading cache from salt://_proxy, for base)
2017-09-25 15:55:23,858 [salt.fileclient  ][INFO    ][21882] Caching directory '_proxy/' for environment 'base'
2017-09-25 15:55:23,901 [salt.utils.extmods][INFO    ][21882] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-25 15:55:23,906 [salt.utils.extmods][INFO    ][21882] Syncing engines for environment 'base'
2017-09-25 15:55:23,916 [salt.utils.extmods][INFO    ][21882] Loading cache from salt://_engines, for base)
2017-09-25 15:55:23,917 [salt.fileclient  ][INFO    ][21882] Caching directory '_engines/' for environment 'base'
2017-09-25 15:55:23,966 [salt.minion      ][INFO    ][21882] Returning information for job: 20170925155516725002
2017-09-25 15:55:24,981 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command state.sls with jid 20170925155524975948
2017-09-25 15:55:25,001 [salt.minion      ][INFO    ][21950] Starting a new job with PID 21950
2017-09-25 15:55:25,387 [salt.state       ][INFO    ][21950] Loading fresh modules for state activity
2017-09-25 15:55:25,411 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-25 15:55:25,430 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-25 15:55:25,457 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 15:55:25,645 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-25 15:55:25,680 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-25 15:55:25,719 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 15:55:25,830 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-25 15:55:25,863 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 15:55:25,954 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-25 15:55:25,998 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-25 15:55:26,017 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 15:55:26,050 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-25 15:55:26,068 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-25 15:55:26,102 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-25 15:55:26,133 [py.warnings      ][WARNING ][21950] /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-09-25 15:55:26,133 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'salt-minion --version' in directory '/root'
2017-09-25 15:55:26,544 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-25 15:55:26,569 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-25 15:55:26,586 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-25 15:55:26,603 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-25 15:55:26,698 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-25 15:55:26,775 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-25 15:55:26,880 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-25 15:55:26,917 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 15:55:27,007 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-25 15:55:27,034 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 15:55:27,142 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-25 15:55:27,170 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-25 15:55:27,188 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 15:55:27,209 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-25 15:55:27,221 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-25 15:55:27,254 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-25 15:55:27,278 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'salt-minion --version' in directory '/root'
2017-09-25 15:55:27,674 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-25 15:55:27,700 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-25 15:55:27,717 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-25 15:55:27,735 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-25 15:55:27,850 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-25 15:55:27,909 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-25 15:55:28,023 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-25 15:55:28,163 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 15:55:28,982 [salt.state       ][INFO    ][21950] Running state [salt-minion] at time 15:55:28.981921
2017-09-25 15:55:28,982 [salt.state       ][INFO    ][21950] Executing state pkg.installed for salt-minion
2017-09-25 15:55:28,983 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 15:55:29,396 [salt.state       ][INFO    ][21950] Package salt-minion is already installed
2017-09-25 15:55:29,396 [salt.state       ][INFO    ][21950] Completed state [salt-minion] at time 15:55:29.396016 duration_in_ms=414.095
2017-09-25 15:55:29,396 [salt.state       ][INFO    ][21950] Running state [python-yaml] at time 15:55:29.396281
2017-09-25 15:55:29,397 [salt.state       ][INFO    ][21950] Executing state pkg.installed for python-yaml
2017-09-25 15:55:29,400 [salt.state       ][INFO    ][21950] Package python-yaml is already installed
2017-09-25 15:55:29,400 [salt.state       ][INFO    ][21950] Completed state [python-yaml] at time 15:55:29.399920 duration_in_ms=3.639
2017-09-25 15:55:29,400 [salt.state       ][INFO    ][21950] Running state [python-psutil] at time 15:55:29.400110
2017-09-25 15:55:29,400 [salt.state       ][INFO    ][21950] Executing state pkg.installed for python-psutil
2017-09-25 15:55:29,403 [salt.state       ][INFO    ][21950] Package python-psutil is already installed
2017-09-25 15:55:29,404 [salt.state       ][INFO    ][21950] Completed state [python-psutil] at time 15:55:29.403583 duration_in_ms=3.473
2017-09-25 15:55:29,404 [salt.state       ][INFO    ][21950] Running state [python-m2crypto] at time 15:55:29.403775
2017-09-25 15:55:29,404 [salt.state       ][INFO    ][21950] Executing state pkg.installed for python-m2crypto
2017-09-25 15:55:29,407 [salt.state       ][INFO    ][21950] Package python-m2crypto is already installed
2017-09-25 15:55:29,407 [salt.state       ][INFO    ][21950] Completed state [python-m2crypto] at time 15:55:29.407167 duration_in_ms=3.393
2017-09-25 15:55:29,409 [salt.state       ][INFO    ][21950] Running state [/etc/salt/minion.d/minion.conf] at time 15:55:29.408903
2017-09-25 15:55:29,409 [salt.state       ][INFO    ][21950] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-25 15:55:29,439 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-25 15:55:29,496 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 15:55:29,548 [salt.fileclient  ][INFO    ][21950] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 15:55:29,588 [salt.state       ][INFO    ][21950] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-25 15:55:29,588 [salt.state       ][INFO    ][21950] Completed state [/etc/salt/minion.d/minion.conf] at time 15:55:29.588300 duration_in_ms=179.397
2017-09-25 15:55:29,589 [salt.state       ][INFO    ][21950] Running state [/etc/salt/minion.d/_virt.conf] at time 15:55:29.588631
2017-09-25 15:55:29,589 [salt.state       ][INFO    ][21950] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-25 15:55:29,619 [salt.state       ][INFO    ][21950] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-25 15:55:29,619 [salt.state       ][INFO    ][21950] Completed state [/etc/salt/minion.d/_virt.conf] at time 15:55:29.618995 duration_in_ms=30.363
2017-09-25 15:55:29,622 [salt.state       ][INFO    ][21950] Running state [salt-minion] at time 15:55:29.621489
2017-09-25 15:55:29,622 [salt.state       ][INFO    ][21950] Executing state service.running for salt-minion
2017-09-25 15:55:29,623 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-25 15:55:29,654 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-25 15:55:29,681 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-25 15:55:29,697 [salt.state       ][INFO    ][21950] The service salt-minion is already running
2017-09-25 15:55:29,738 [salt.state       ][INFO    ][21950] Completed state [salt-minion] at time 15:55:29.737444 duration_in_ms=115.954
2017-09-25 15:55:29,740 [salt.state       ][INFO    ][21950] Running state [/etc/salt/grains.d] at time 15:55:29.740114
2017-09-25 15:55:29,741 [salt.state       ][INFO    ][21950] Executing state file.directory for /etc/salt/grains.d
2017-09-25 15:55:29,742 [salt.state       ][INFO    ][21950] Directory /etc/salt/grains.d is in the correct state
2017-09-25 15:55:29,742 [salt.state       ][INFO    ][21950] Completed state [/etc/salt/grains.d] at time 15:55:29.742112 duration_in_ms=1.998
2017-09-25 15:55:29,743 [salt.state       ][INFO    ][21950] Running state [/etc/salt/grains] at time 15:55:29.743346
2017-09-25 15:55:29,754 [salt.state       ][INFO    ][21950] Executing state file.managed for /etc/salt/grains
2017-09-25 15:55:29,755 [salt.state       ][INFO    ][21950] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-25 15:55:29,755 [salt.state       ][INFO    ][21950] Completed state [/etc/salt/grains] at time 15:55:29.755231 duration_in_ms=11.884
2017-09-25 15:55:29,756 [salt.state       ][INFO    ][21950] Running state [/etc/salt/grains.d/placeholder] at time 15:55:29.756023
2017-09-25 15:55:29,757 [salt.state       ][INFO    ][21950] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-25 15:55:29,757 [salt.state       ][INFO    ][21950] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-25 15:55:29,758 [salt.state       ][INFO    ][21950] Completed state [/etc/salt/grains.d/placeholder] at time 15:55:29.757602 duration_in_ms=1.578
2017-09-25 15:55:29,758 [salt.state       ][INFO    ][21950] Running state [/etc/salt/grains.d/sphinx] at time 15:55:29.758344
2017-09-25 15:55:29,759 [salt.state       ][INFO    ][21950] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-25 15:55:29,840 [salt.state       ][INFO    ][21950] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.143
               - 127.0.0.1
               - 192.168.11.251
-              - 192.168.122.1
         system:
           name: System
           param:

2017-09-25 15:55:29,841 [salt.state       ][INFO    ][21950] Completed state [/etc/salt/grains.d/sphinx] at time 15:55:29.840631 duration_in_ms=82.286
2017-09-25 15:55:29,842 [salt.state       ][INFO    ][21950] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 15:55:29.841818
2017-09-25 15:55:29,842 [salt.state       ][INFO    ][21950] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-25 15:55:29,843 [salt.state       ][INFO    ][21950] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-25 15:55:29,843 [salt.state       ][INFO    ][21950] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 15:55:29.843098 duration_in_ms=1.281
2017-09-25 15:55:29,843 [salt.state       ][INFO    ][21950] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 15:55:29.843434
2017-09-25 15:55:29,844 [salt.state       ][INFO    ][21950] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-25 15:55:29,845 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-09-25 15:55:29,991 [salt.state       ][INFO    ][21950] {'pid': 22034, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-09-25 15:55:29,992 [salt.state       ][INFO    ][21950] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 15:55:29.992171 duration_in_ms=148.736
2017-09-25 15:55:29,993 [salt.state       ][INFO    ][21950] Running state [/etc/salt/grains.d/dns_records] at time 15:55:29.993206
2017-09-25 15:55:29,994 [salt.state       ][INFO    ][21950] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-25 15:55:30,096 [salt.state       ][INFO    ][21950] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-25 15:55:30,097 [salt.state       ][INFO    ][21950] Completed state [/etc/salt/grains.d/dns_records] at time 15:55:30.096626 duration_in_ms=103.42
2017-09-25 15:55:30,098 [salt.state       ][INFO    ][21950] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 15:55:30.098007
2017-09-25 15:55:30,099 [salt.state       ][INFO    ][21950] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-25 15:55:30,099 [salt.state       ][INFO    ][21950] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-25 15:55:30,099 [salt.state       ][INFO    ][21950] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 15:55:30.099353 duration_in_ms=1.346
2017-09-25 15:55:30,100 [salt.state       ][INFO    ][21950] Running state [/etc/salt/grains.d/salt] at time 15:55:30.100149
2017-09-25 15:55:30,101 [salt.state       ][INFO    ][21950] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-25 15:55:30,158 [salt.state       ][INFO    ][21950] File /etc/salt/grains.d/salt is in the correct state
2017-09-25 15:55:30,158 [salt.state       ][INFO    ][21950] Completed state [/etc/salt/grains.d/salt] at time 15:55:30.158205 duration_in_ms=58.056
2017-09-25 15:55:30,159 [salt.state       ][INFO    ][21950] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 15:55:30.159386
2017-09-25 15:55:30,160 [salt.state       ][INFO    ][21950] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-25 15:55:30,161 [salt.state       ][INFO    ][21950] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-25 15:55:30,161 [salt.state       ][INFO    ][21950] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 15:55:30.160825 duration_in_ms=1.439
2017-09-25 15:55:30,164 [salt.state       ][INFO    ][21950] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 15:55:30.164262
2017-09-25 15:55:30,165 [salt.state       ][INFO    ][21950] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-25 15:55:30,165 [salt.state       ][INFO    ][21950] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-25 15:55:30,166 [salt.state       ][INFO    ][21950] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 15:55:30.165569 duration_in_ms=1.306
2017-09-25 15:55:30,166 [salt.state       ][INFO    ][21950] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 15:55:30.165905
2017-09-25 15:55:30,166 [salt.state       ][INFO    ][21950] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-25 15:55:30,169 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-09-25 15:55:30,185 [salt.state       ][INFO    ][21950] {'pid': 22036, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-09-25 15:55:30,186 [salt.state       ][INFO    ][21950] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 15:55:30.185425 duration_in_ms=19.52
2017-09-25 15:55:30,187 [salt.state       ][INFO    ][21950] Running state [mine.update] at time 15:55:30.186928
2017-09-25 15:55:30,187 [salt.state       ][INFO    ][21950] Executing state module.wait for mine.update
2017-09-25 15:55:30,188 [salt.state       ][INFO    ][21950] No changes made for mine.update
2017-09-25 15:55:30,188 [salt.state       ][INFO    ][21950] Completed state [mine.update] at time 15:55:30.188328 duration_in_ms=1.4
2017-09-25 15:55:30,189 [salt.state       ][INFO    ][21950] Running state [mine.update] at time 15:55:30.188673
2017-09-25 15:55:30,189 [salt.state       ][INFO    ][21950] Executing state module.mod_watch for mine.update
2017-09-25 15:55:30,725 [salt.state       ][INFO    ][21950] {'ret': True}
2017-09-25 15:55:30,726 [salt.state       ][INFO    ][21950] Completed state [mine.update] at time 15:55:30.725646 duration_in_ms=536.972
2017-09-25 15:55:30,726 [salt.state       ][INFO    ][21950] Running state [ca-certificates] at time 15:55:30.726217
2017-09-25 15:55:30,727 [salt.state       ][INFO    ][21950] Executing state pkg.installed for ca-certificates
2017-09-25 15:55:30,735 [salt.state       ][INFO    ][21950] Package ca-certificates is already installed
2017-09-25 15:55:30,736 [salt.state       ][INFO    ][21950] Completed state [ca-certificates] at time 15:55:30.735468 duration_in_ms=9.251
2017-09-25 15:55:30,737 [salt.state       ][INFO    ][21950] Running state [update-ca-certificates] at time 15:55:30.736755
2017-09-25 15:55:30,737 [salt.state       ][INFO    ][21950] Executing state cmd.wait for update-ca-certificates
2017-09-25 15:55:30,738 [salt.state       ][INFO    ][21950] No changes made for update-ca-certificates
2017-09-25 15:55:30,738 [salt.state       ][INFO    ][21950] Completed state [update-ca-certificates] at time 15:55:30.737950 duration_in_ms=1.194
2017-09-25 15:55:30,738 [salt.state       ][INFO    ][21950] Running state [libvirt-dev] at time 15:55:30.738316
2017-09-25 15:55:30,739 [salt.state       ][INFO    ][21950] Executing state pkg.installed for libvirt-dev
2017-09-25 15:55:30,746 [salt.state       ][INFO    ][21950] Package libvirt-dev is already installed
2017-09-25 15:55:30,747 [salt.state       ][INFO    ][21950] Completed state [libvirt-dev] at time 15:55:30.746451 duration_in_ms=8.134
2017-09-25 15:55:30,747 [salt.state       ][INFO    ][21950] Running state [pkg-config] at time 15:55:30.746817
2017-09-25 15:55:30,747 [salt.state       ][INFO    ][21950] Executing state pkg.installed for pkg-config
2017-09-25 15:55:30,754 [salt.state       ][INFO    ][21950] Package pkg-config is already installed
2017-09-25 15:55:30,755 [salt.state       ][INFO    ][21950] Completed state [pkg-config] at time 15:55:30.754454 duration_in_ms=7.637
2017-09-25 15:55:30,755 [salt.state       ][INFO    ][21950] Running state [virtng.init] at time 15:55:30.754800
2017-09-25 15:55:30,755 [salt.state       ][INFO    ][21950] Executing state module.run for virtng.init
2017-09-25 15:55:30,900 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command ['git', '--version'] in directory '/root'
2017-09-25 15:55:31,025 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:55:31,064 [salt.state       ][INFO    ][21950] unless execution succeeded
2017-09-25 15:55:31,065 [salt.state       ][INFO    ][21950] Completed state [virtng.init] at time 15:55:31.064530 duration_in_ms=309.726
2017-09-25 15:55:31,065 [salt.state       ][INFO    ][21950] Running state [virt.set_autostart] at time 15:55:31.065380
2017-09-25 15:55:31,066 [salt.state       ][INFO    ][21950] Executing state module.run for virt.set_autostart
2017-09-25 15:55:31,071 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:55:31,103 [salt.state       ][INFO    ][21950] unless execution succeeded
2017-09-25 15:55:31,110 [salt.state       ][INFO    ][21950] Completed state [virt.set_autostart] at time 15:55:31.109909 duration_in_ms=44.528
2017-09-25 15:55:31,111 [salt.state       ][INFO    ][21950] Running state [virtng.init] at time 15:55:31.110458
2017-09-25 15:55:31,111 [salt.state       ][INFO    ][21950] Executing state module.run for virtng.init
2017-09-25 15:55:31,115 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:55:31,147 [salt.state       ][INFO    ][21950] unless execution succeeded
2017-09-25 15:55:31,148 [salt.state       ][INFO    ][21950] Completed state [virtng.init] at time 15:55:31.147445 duration_in_ms=36.985
2017-09-25 15:55:31,148 [salt.state       ][INFO    ][21950] Running state [virt.set_autostart] at time 15:55:31.148052
2017-09-25 15:55:31,148 [salt.state       ][INFO    ][21950] Executing state module.run for virt.set_autostart
2017-09-25 15:55:31,152 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:55:31,186 [salt.state       ][INFO    ][21950] unless execution succeeded
2017-09-25 15:55:31,187 [salt.state       ][INFO    ][21950] Completed state [virt.set_autostart] at time 15:55:31.186574 duration_in_ms=38.52
2017-09-25 15:55:31,187 [salt.state       ][INFO    ][21950] Running state [virtng.init] at time 15:55:31.187160
2017-09-25 15:55:31,188 [salt.state       ][INFO    ][21950] Executing state module.run for virtng.init
2017-09-25 15:55:31,193 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:55:31,224 [salt.state       ][INFO    ][21950] unless execution succeeded
2017-09-25 15:55:31,262 [salt.state       ][INFO    ][21950] Completed state [virtng.init] at time 15:55:31.261574 duration_in_ms=74.413
2017-09-25 15:55:31,263 [salt.state       ][INFO    ][21950] Running state [virt.set_autostart] at time 15:55:31.262377
2017-09-25 15:55:31,263 [salt.state       ][INFO    ][21950] Executing state module.run for virt.set_autostart
2017-09-25 15:55:31,268 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:55:31,303 [salt.state       ][INFO    ][21950] unless execution succeeded
2017-09-25 15:55:31,304 [salt.state       ][INFO    ][21950] Completed state [virt.set_autostart] at time 15:55:31.303500 duration_in_ms=41.124
2017-09-25 15:55:31,304 [salt.state       ][INFO    ][21950] Running state [virtng.init] at time 15:55:31.304098
2017-09-25 15:55:31,305 [salt.state       ][INFO    ][21950] Executing state module.run for virtng.init
2017-09-25 15:55:31,309 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:55:31,341 [salt.state       ][INFO    ][21950] unless execution succeeded
2017-09-25 15:55:31,341 [salt.state       ][INFO    ][21950] Completed state [virtng.init] at time 15:55:31.340978 duration_in_ms=36.88
2017-09-25 15:55:31,342 [salt.state       ][INFO    ][21950] Running state [virt.set_autostart] at time 15:55:31.341488
2017-09-25 15:55:31,342 [salt.state       ][INFO    ][21950] Executing state module.run for virt.set_autostart
2017-09-25 15:55:31,347 [salt.loaded.int.module.cmdmod][INFO    ][21950] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:55:31,385 [salt.state       ][INFO    ][21950] unless execution succeeded
2017-09-25 15:55:31,386 [salt.state       ][INFO    ][21950] Completed state [virt.set_autostart] at time 15:55:31.385623 duration_in_ms=44.134
2017-09-25 15:55:31,401 [salt.minion      ][INFO    ][21950] Returning information for job: 20170925155524975948
2017-09-25 15:55:56,004 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command state.sls with jid 20170925155555995590
2017-09-25 15:55:56,026 [salt.minion      ][INFO    ][22088] Starting a new job with PID 22088
2017-09-25 15:55:58,487 [salt.state       ][INFO    ][22088] Loading fresh modules for state activity
2017-09-25 15:55:58,531 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-25 15:55:58,559 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-25 15:55:58,712 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 15:55:58,859 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-25 15:55:58,883 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-25 15:55:58,928 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 15:55:59,016 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-25 15:55:59,042 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 15:55:59,107 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-25 15:55:59,130 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-25 15:55:59,145 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 15:55:59,171 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-25 15:55:59,188 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-25 15:55:59,223 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-25 15:55:59,256 [py.warnings      ][WARNING ][22088] /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-09-25 15:55:59,257 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command 'salt-minion --version' in directory '/root'
2017-09-25 15:55:59,633 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-25 15:55:59,658 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-25 15:55:59,674 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-25 15:55:59,690 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-25 15:55:59,829 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-25 15:55:59,887 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-25 15:55:59,984 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-25 15:56:00,015 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 15:56:00,154 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-25 15:56:00,188 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 15:56:00,281 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-25 15:56:00,311 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-25 15:56:00,331 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 15:56:00,357 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-25 15:56:00,372 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-25 15:56:00,409 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-25 15:56:00,443 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command 'salt-minion --version' in directory '/root'
2017-09-25 15:56:00,825 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-25 15:56:00,850 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-25 15:56:00,865 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-25 15:56:00,883 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-25 15:56:01,000 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-25 15:56:01,073 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-25 15:56:01,190 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-25 15:56:01,276 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 15:56:01,809 [salt.state       ][INFO    ][22088] Running state [salt-minion] at time 15:56:01.809410
2017-09-25 15:56:01,810 [salt.state       ][INFO    ][22088] Executing state pkg.installed for salt-minion
2017-09-25 15:56:01,810 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 15:56:02,247 [salt.state       ][INFO    ][22088] Package salt-minion is already installed
2017-09-25 15:56:02,247 [salt.state       ][INFO    ][22088] Completed state [salt-minion] at time 15:56:02.247353 duration_in_ms=437.942
2017-09-25 15:56:02,248 [salt.state       ][INFO    ][22088] Running state [python-yaml] at time 15:56:02.247650
2017-09-25 15:56:02,248 [salt.state       ][INFO    ][22088] Executing state pkg.installed for python-yaml
2017-09-25 15:56:02,252 [salt.state       ][INFO    ][22088] Package python-yaml is already installed
2017-09-25 15:56:02,252 [salt.state       ][INFO    ][22088] Completed state [python-yaml] at time 15:56:02.252103 duration_in_ms=4.452
2017-09-25 15:56:02,252 [salt.state       ][INFO    ][22088] Running state [python-psutil] at time 15:56:02.252316
2017-09-25 15:56:02,253 [salt.state       ][INFO    ][22088] Executing state pkg.installed for python-psutil
2017-09-25 15:56:02,256 [salt.state       ][INFO    ][22088] Package python-psutil is already installed
2017-09-25 15:56:02,257 [salt.state       ][INFO    ][22088] Completed state [python-psutil] at time 15:56:02.256498 duration_in_ms=4.181
2017-09-25 15:56:02,257 [salt.state       ][INFO    ][22088] Running state [python-m2crypto] at time 15:56:02.256706
2017-09-25 15:56:02,257 [salt.state       ][INFO    ][22088] Executing state pkg.installed for python-m2crypto
2017-09-25 15:56:02,261 [salt.state       ][INFO    ][22088] Package python-m2crypto is already installed
2017-09-25 15:56:02,261 [salt.state       ][INFO    ][22088] Completed state [python-m2crypto] at time 15:56:02.260898 duration_in_ms=4.192
2017-09-25 15:56:02,263 [salt.state       ][INFO    ][22088] Running state [/etc/salt/minion.d/minion.conf] at time 15:56:02.262894
2017-09-25 15:56:02,263 [salt.state       ][INFO    ][22088] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-25 15:56:02,286 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-25 15:56:02,345 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-25 15:56:02,397 [salt.fileclient  ][INFO    ][22088] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-25 15:56:02,436 [salt.state       ][INFO    ][22088] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-25 15:56:02,436 [salt.state       ][INFO    ][22088] Completed state [/etc/salt/minion.d/minion.conf] at time 15:56:02.435834 duration_in_ms=172.939
2017-09-25 15:56:02,436 [salt.state       ][INFO    ][22088] Running state [/etc/salt/minion.d/_virt.conf] at time 15:56:02.436188
2017-09-25 15:56:02,436 [salt.state       ][INFO    ][22088] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-25 15:56:02,514 [salt.state       ][INFO    ][22088] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-25 15:56:02,515 [salt.state       ][INFO    ][22088] Completed state [/etc/salt/minion.d/_virt.conf] at time 15:56:02.514762 duration_in_ms=78.573
2017-09-25 15:56:02,518 [salt.state       ][INFO    ][22088] Running state [salt-minion] at time 15:56:02.517534
2017-09-25 15:56:02,518 [salt.state       ][INFO    ][22088] Executing state service.running for salt-minion
2017-09-25 15:56:02,519 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-25 15:56:02,550 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-25 15:56:02,579 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-25 15:56:02,593 [salt.state       ][INFO    ][22088] The service salt-minion is already running
2017-09-25 15:56:02,594 [salt.state       ][INFO    ][22088] Completed state [salt-minion] at time 15:56:02.593426 duration_in_ms=75.892
2017-09-25 15:56:02,596 [salt.state       ][INFO    ][22088] Running state [/etc/salt/grains.d] at time 15:56:02.595759
2017-09-25 15:56:02,596 [salt.state       ][INFO    ][22088] Executing state file.directory for /etc/salt/grains.d
2017-09-25 15:56:02,597 [salt.state       ][INFO    ][22088] Directory /etc/salt/grains.d is in the correct state
2017-09-25 15:56:02,598 [salt.state       ][INFO    ][22088] Completed state [/etc/salt/grains.d] at time 15:56:02.597632 duration_in_ms=1.873
2017-09-25 15:56:02,599 [salt.state       ][INFO    ][22088] Running state [/etc/salt/grains] at time 15:56:02.598648
2017-09-25 15:56:02,599 [salt.state       ][INFO    ][22088] Executing state file.managed for /etc/salt/grains
2017-09-25 15:56:02,600 [salt.state       ][INFO    ][22088] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-25 15:56:02,600 [salt.state       ][INFO    ][22088] Completed state [/etc/salt/grains] at time 15:56:02.600047 duration_in_ms=1.398
2017-09-25 15:56:02,601 [salt.state       ][INFO    ][22088] Running state [/etc/salt/grains.d/placeholder] at time 15:56:02.600671
2017-09-25 15:56:02,601 [salt.state       ][INFO    ][22088] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-25 15:56:02,602 [salt.state       ][INFO    ][22088] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-25 15:56:02,602 [salt.state       ][INFO    ][22088] Completed state [/etc/salt/grains.d/placeholder] at time 15:56:02.601979 duration_in_ms=1.308
2017-09-25 15:56:02,603 [salt.state       ][INFO    ][22088] Running state [/etc/salt/grains.d/sphinx] at time 15:56:02.602601
2017-09-25 15:56:02,603 [salt.state       ][INFO    ][22088] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-25 15:56:02,688 [salt.state       ][INFO    ][22088] File /etc/salt/grains.d/sphinx is in the correct state
2017-09-25 15:56:02,689 [salt.state       ][INFO    ][22088] Completed state [/etc/salt/grains.d/sphinx] at time 15:56:02.688478 duration_in_ms=85.876
2017-09-25 15:56:02,690 [salt.state       ][INFO    ][22088] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 15:56:02.689649
2017-09-25 15:56:02,690 [salt.state       ][INFO    ][22088] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-25 15:56:02,691 [salt.state       ][INFO    ][22088] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-25 15:56:02,691 [salt.state       ][INFO    ][22088] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 15:56:02.690957 duration_in_ms=1.308
2017-09-25 15:56:02,692 [salt.state       ][INFO    ][22088] Running state [/etc/salt/grains.d/dns_records] at time 15:56:02.691748
2017-09-25 15:56:02,692 [salt.state       ][INFO    ][22088] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-25 15:56:02,820 [salt.state       ][INFO    ][22088] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-25 15:56:02,820 [salt.state       ][INFO    ][22088] Completed state [/etc/salt/grains.d/dns_records] at time 15:56:02.820227 duration_in_ms=128.479
2017-09-25 15:56:02,822 [salt.state       ][INFO    ][22088] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 15:56:02.821471
2017-09-25 15:56:02,822 [salt.state       ][INFO    ][22088] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-25 15:56:02,822 [salt.state       ][INFO    ][22088] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-25 15:56:02,823 [salt.state       ][INFO    ][22088] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 15:56:02.822781 duration_in_ms=1.31
2017-09-25 15:56:02,824 [salt.state       ][INFO    ][22088] Running state [/etc/salt/grains.d/salt] at time 15:56:02.823510
2017-09-25 15:56:02,824 [salt.state       ][INFO    ][22088] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-25 15:56:02,905 [salt.state       ][INFO    ][22088] File /etc/salt/grains.d/salt is in the correct state
2017-09-25 15:56:02,906 [salt.state       ][INFO    ][22088] Completed state [/etc/salt/grains.d/salt] at time 15:56:02.905506 duration_in_ms=81.996
2017-09-25 15:56:02,907 [salt.state       ][INFO    ][22088] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 15:56:02.906639
2017-09-25 15:56:02,907 [salt.state       ][INFO    ][22088] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-25 15:56:02,908 [salt.state       ][INFO    ][22088] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-25 15:56:02,908 [salt.state       ][INFO    ][22088] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 15:56:02.907887 duration_in_ms=1.248
2017-09-25 15:56:02,911 [salt.state       ][INFO    ][22088] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 15:56:02.910881
2017-09-25 15:56:02,911 [salt.state       ][INFO    ][22088] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-25 15:56:02,912 [salt.state       ][INFO    ][22088] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-25 15:56:02,912 [salt.state       ][INFO    ][22088] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 15:56:02.912031 duration_in_ms=1.149
2017-09-25 15:56:02,913 [salt.state       ][INFO    ][22088] Running state [mine.update] at time 15:56:02.913005
2017-09-25 15:56:02,913 [salt.state       ][INFO    ][22088] Executing state module.wait for mine.update
2017-09-25 15:56:02,914 [salt.state       ][INFO    ][22088] No changes made for mine.update
2017-09-25 15:56:02,914 [salt.state       ][INFO    ][22088] Completed state [mine.update] at time 15:56:02.914030 duration_in_ms=1.025
2017-09-25 15:56:02,914 [salt.state       ][INFO    ][22088] Running state [ca-certificates] at time 15:56:02.914355
2017-09-25 15:56:02,915 [salt.state       ][INFO    ][22088] Executing state pkg.installed for ca-certificates
2017-09-25 15:56:02,922 [salt.state       ][INFO    ][22088] Package ca-certificates is already installed
2017-09-25 15:56:02,922 [salt.state       ][INFO    ][22088] Completed state [ca-certificates] at time 15:56:02.922244 duration_in_ms=7.889
2017-09-25 15:56:02,923 [salt.state       ][INFO    ][22088] Running state [update-ca-certificates] at time 15:56:02.923183
2017-09-25 15:56:02,924 [salt.state       ][INFO    ][22088] Executing state cmd.wait for update-ca-certificates
2017-09-25 15:56:02,924 [salt.state       ][INFO    ][22088] No changes made for update-ca-certificates
2017-09-25 15:56:02,924 [salt.state       ][INFO    ][22088] Completed state [update-ca-certificates] at time 15:56:02.924217 duration_in_ms=1.034
2017-09-25 15:56:02,925 [salt.state       ][INFO    ][22088] Running state [libvirt-dev] at time 15:56:02.924531
2017-09-25 15:56:02,925 [salt.state       ][INFO    ][22088] Executing state pkg.installed for libvirt-dev
2017-09-25 15:56:02,931 [salt.state       ][INFO    ][22088] Package libvirt-dev is already installed
2017-09-25 15:56:02,932 [salt.state       ][INFO    ][22088] Completed state [libvirt-dev] at time 15:56:02.931523 duration_in_ms=6.992
2017-09-25 15:56:02,932 [salt.state       ][INFO    ][22088] Running state [pkg-config] at time 15:56:02.931874
2017-09-25 15:56:02,932 [salt.state       ][INFO    ][22088] Executing state pkg.installed for pkg-config
2017-09-25 15:56:02,938 [salt.state       ][INFO    ][22088] Package pkg-config is already installed
2017-09-25 15:56:02,939 [salt.state       ][INFO    ][22088] Completed state [pkg-config] at time 15:56:02.938451 duration_in_ms=6.577
2017-09-25 15:56:02,939 [salt.state       ][INFO    ][22088] Running state [virtng.init] at time 15:56:02.938763
2017-09-25 15:56:02,939 [salt.state       ][INFO    ][22088] Executing state module.run for virtng.init
2017-09-25 15:56:03,009 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command ['git', '--version'] in directory '/root'
2017-09-25 15:56:03,119 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:56:03,149 [salt.state       ][INFO    ][22088] unless execution succeeded
2017-09-25 15:56:03,149 [salt.state       ][INFO    ][22088] Completed state [virtng.init] at time 15:56:03.149179 duration_in_ms=210.413
2017-09-25 15:56:03,149 [salt.state       ][INFO    ][22088] Running state [virt.set_autostart] at time 15:56:03.149441
2017-09-25 15:56:03,150 [salt.state       ][INFO    ][22088] Executing state module.run for virt.set_autostart
2017-09-25 15:56:03,152 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:56:03,177 [salt.state       ][INFO    ][22088] unless execution succeeded
2017-09-25 15:56:03,177 [salt.state       ][INFO    ][22088] Completed state [virt.set_autostart] at time 15:56:03.176859 duration_in_ms=27.418
2017-09-25 15:56:03,177 [salt.state       ][INFO    ][22088] Running state [virtng.init] at time 15:56:03.177102
2017-09-25 15:56:03,177 [salt.state       ][INFO    ][22088] Executing state module.run for virtng.init
2017-09-25 15:56:03,179 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:56:03,204 [salt.state       ][INFO    ][22088] unless execution succeeded
2017-09-25 15:56:03,204 [salt.state       ][INFO    ][22088] Completed state [virtng.init] at time 15:56:03.204066 duration_in_ms=26.963
2017-09-25 15:56:03,204 [salt.state       ][INFO    ][22088] Running state [virt.set_autostart] at time 15:56:03.204322
2017-09-25 15:56:03,205 [salt.state       ][INFO    ][22088] Executing state module.run for virt.set_autostart
2017-09-25 15:56:03,207 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:56:03,228 [salt.state       ][INFO    ][22088] unless execution succeeded
2017-09-25 15:56:03,273 [salt.state       ][INFO    ][22088] Completed state [virt.set_autostart] at time 15:56:03.273290 duration_in_ms=68.965
2017-09-25 15:56:03,274 [salt.state       ][INFO    ][22088] Running state [virtng.init] at time 15:56:03.273845
2017-09-25 15:56:03,274 [salt.state       ][INFO    ][22088] Executing state module.run for virtng.init
2017-09-25 15:56:03,279 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:56:03,316 [salt.state       ][INFO    ][22088] unless execution succeeded
2017-09-25 15:56:03,316 [salt.state       ][INFO    ][22088] Completed state [virtng.init] at time 15:56:03.316095 duration_in_ms=42.249
2017-09-25 15:56:03,317 [salt.state       ][INFO    ][22088] Running state [virt.set_autostart] at time 15:56:03.316612
2017-09-25 15:56:03,317 [salt.state       ][INFO    ][22088] Executing state module.run for virt.set_autostart
2017-09-25 15:56:03,322 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:56:03,357 [salt.state       ][INFO    ][22088] unless execution succeeded
2017-09-25 15:56:03,357 [salt.state       ][INFO    ][22088] Completed state [virt.set_autostart] at time 15:56:03.357023 duration_in_ms=40.408
2017-09-25 15:56:03,358 [salt.state       ][INFO    ][22088] Running state [virtng.init] at time 15:56:03.357593
2017-09-25 15:56:03,358 [salt.state       ][INFO    ][22088] Executing state module.run for virtng.init
2017-09-25 15:56:03,363 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:56:03,394 [salt.state       ][INFO    ][22088] unless execution succeeded
2017-09-25 15:56:03,395 [salt.state       ][INFO    ][22088] Completed state [virtng.init] at time 15:56:03.394684 duration_in_ms=37.09
2017-09-25 15:56:03,395 [salt.state       ][INFO    ][22088] Running state [virt.set_autostart] at time 15:56:03.395170
2017-09-25 15:56:03,396 [salt.state       ][INFO    ][22088] Executing state module.run for virt.set_autostart
2017-09-25 15:56:03,400 [salt.loaded.int.module.cmdmod][INFO    ][22088] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-25 15:56:03,430 [salt.state       ][INFO    ][22088] unless execution succeeded
2017-09-25 15:56:03,431 [salt.state       ][INFO    ][22088] Completed state [virt.set_autostart] at time 15:56:03.430621 duration_in_ms=35.45
2017-09-25 15:56:03,436 [salt.minion      ][INFO    ][22088] Returning information for job: 20170925155555995590
2017-09-25 15:56:56,304 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170925155656298132
2017-09-25 15:56:56,331 [salt.minion      ][INFO    ][22182] Starting a new job with PID 22182
2017-09-25 15:56:58,518 [salt.state       ][INFO    ][22182] Loading fresh modules for state activity
2017-09-25 15:56:58,681 [salt.state       ][ERROR   ][22182] No contents found in top file
2017-09-25 15:56:58,682 [salt.utils.extmods][INFO    ][22182] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-25 15:56:58,689 [salt.utils.extmods][INFO    ][22182] Syncing beacons for environment 'base'
2017-09-25 15:56:58,689 [salt.utils.extmods][INFO    ][22182] Loading cache from salt://_beacons, for base)
2017-09-25 15:56:58,689 [salt.fileclient  ][INFO    ][22182] Caching directory '_beacons/' for environment 'base'
2017-09-25 15:56:58,723 [salt.utils.extmods][INFO    ][22182] Syncing modules for environment 'base'
2017-09-25 15:56:58,723 [salt.utils.extmods][INFO    ][22182] Loading cache from salt://_modules, for base)
2017-09-25 15:56:58,723 [salt.fileclient  ][INFO    ][22182] Caching directory '_modules/' for environment 'base'
2017-09-25 15:56:59,090 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-25 15:56:59,100 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-25 15:56:59,117 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-25 15:56:59,153 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-25 15:56:59,183 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-25 15:56:59,209 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-25 15:56:59,229 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-25 15:56:59,240 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-25 15:56:59,260 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-25 15:56:59,290 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-25 15:56:59,352 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-25 15:56:59,363 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-25 15:56:59,400 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-25 15:56:59,411 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-25 15:56:59,432 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-25 15:56:59,443 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-25 15:56:59,457 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-25 15:56:59,481 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-25 15:56:59,492 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-25 15:56:59,538 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-25 15:56:59,564 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-25 15:56:59,609 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-25 15:56:59,653 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-25 15:56:59,697 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-25 15:56:59,719 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-25 15:56:59,735 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-25 15:56:59,749 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-25 15:56:59,799 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-25 15:56:59,831 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-25 15:56:59,852 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-25 15:56:59,879 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-25 15:56:59,914 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-25 15:56:59,921 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-25 15:56:59,921 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-25 15:56:59,922 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-25 15:56:59,923 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-25 15:56:59,923 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-25 15:56:59,924 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-25 15:56:59,925 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-25 15:56:59,925 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-25 15:56:59,926 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-25 15:56:59,927 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-25 15:56:59,927 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-25 15:56:59,928 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-25 15:56:59,928 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-25 15:56:59,929 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-25 15:56:59,930 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-25 15:56:59,930 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-25 15:56:59,931 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-25 15:56:59,931 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-25 15:56:59,932 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-25 15:56:59,933 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-25 15:56:59,934 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-25 15:56:59,934 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-25 15:56:59,935 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-25 15:56:59,936 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-25 15:56:59,937 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-25 15:56:59,938 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-25 15:56:59,938 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-25 15:56:59,939 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-25 15:56:59,939 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-25 15:56:59,940 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-25 15:56:59,940 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-25 15:56:59,941 [salt.utils.extmods][INFO    ][22182] 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-09-25 15:56:59,942 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-25 15:56:59,942 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-25 15:56:59,952 [salt.utils.extmods][INFO    ][22182] Syncing states for environment 'base'
2017-09-25 15:56:59,952 [salt.utils.extmods][INFO    ][22182] Loading cache from salt://_states, for base)
2017-09-25 15:56:59,953 [salt.fileclient  ][INFO    ][22182] Caching directory '_states/' for environment 'base'
2017-09-25 15:57:00,028 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-25 15:57:00,059 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-25 15:57:00,075 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-25 15:57:00,087 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-25 15:57:00,114 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-25 15:57:00,132 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-25 15:57:00,164 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-25 15:57:00,207 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-25 15:57:00,243 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-25 15:57:00,254 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-25 15:57:00,317 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-25 15:57:00,364 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-25 15:57:00,375 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-25 15:57:00,393 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-25 15:57:00,416 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-25 15:57:00,428 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-25 15:57:00,444 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-25 15:57:00,477 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-25 15:57:00,490 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-25 15:57:00,542 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-25 15:57:00,558 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-25 15:57:00,572 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-25 15:57:00,588 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-25 15:57:00,620 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-25 15:57:00,632 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-25 15:57:00,650 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-25 15:57:00,672 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-25 15:57:00,725 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-25 15:57:00,746 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-25 15:57:00,750 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-25 15:57:00,750 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-25 15:57:00,751 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-25 15:57:00,751 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-25 15:57:00,751 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-25 15:57:00,752 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-25 15:57:00,752 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-25 15:57:00,752 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-25 15:57:00,753 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-25 15:57:00,753 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-25 15:57:00,753 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-25 15:57:00,754 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-25 15:57:00,754 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-25 15:57:00,755 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-25 15:57:00,755 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-25 15:57:00,755 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-25 15:57:00,756 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-25 15:57:00,756 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-25 15:57:00,757 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-25 15:57:00,757 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-25 15:57:00,757 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-25 15:57:00,758 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-25 15:57:00,758 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-25 15:57:00,759 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-25 15:57:00,759 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-25 15:57:00,760 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-25 15:57:00,760 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-25 15:57:00,760 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-25 15:57:00,761 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-25 15:57:00,761 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-25 15:57:00,765 [salt.utils.extmods][INFO    ][22182] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-25 15:57:00,772 [salt.utils.extmods][INFO    ][22182] Syncing sdb for environment 'base'
2017-09-25 15:57:00,772 [salt.utils.extmods][INFO    ][22182] Loading cache from salt://_sdb, for base)
2017-09-25 15:57:00,772 [salt.fileclient  ][INFO    ][22182] Caching directory '_sdb/' for environment 'base'
2017-09-25 15:57:00,814 [salt.utils.extmods][INFO    ][22182] Syncing grains for environment 'base'
2017-09-25 15:57:00,814 [salt.utils.extmods][INFO    ][22182] Loading cache from salt://_grains, for base)
2017-09-25 15:57:00,814 [salt.fileclient  ][INFO    ][22182] Caching directory '_grains/' for environment 'base'
2017-09-25 15:57:00,848 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-25 15:57:00,860 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-25 15:57:00,879 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-25 15:57:00,888 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-25 15:57:00,897 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-25 15:57:00,909 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-25 15:57:00,932 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-25 15:57:00,942 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-25 15:57:00,951 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-25 15:57:00,960 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-25 15:57:00,970 [salt.fileclient  ][INFO    ][22182] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-25 15:57:00,975 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-25 15:57:00,976 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-25 15:57:00,976 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-25 15:57:00,976 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-25 15:57:00,977 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-25 15:57:00,977 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-25 15:57:00,977 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-25 15:57:00,978 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-25 15:57:00,978 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-25 15:57:00,979 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-25 15:57:00,979 [salt.utils.extmods][INFO    ][22182] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-25 15:57:00,982 [salt.utils.extmods][INFO    ][22182] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-25 15:57:00,985 [salt.utils.extmods][INFO    ][22182] Syncing renderers for environment 'base'
2017-09-25 15:57:00,986 [salt.utils.extmods][INFO    ][22182] Loading cache from salt://_renderers, for base)
2017-09-25 15:57:00,986 [salt.fileclient  ][INFO    ][22182] Caching directory '_renderers/' for environment 'base'
2017-09-25 15:57:01,021 [salt.utils.extmods][INFO    ][22182] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-25 15:57:01,025 [salt.utils.extmods][INFO    ][22182] Syncing returners for environment 'base'
2017-09-25 15:57:01,026 [salt.utils.extmods][INFO    ][22182] Loading cache from salt://_returners, for base)
2017-09-25 15:57:01,026 [salt.fileclient  ][INFO    ][22182] Caching directory '_returners/' for environment 'base'
2017-09-25 15:57:01,065 [salt.utils.extmods][INFO    ][22182] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-25 15:57:01,068 [salt.utils.extmods][INFO    ][22182] Syncing output for environment 'base'
2017-09-25 15:57:01,068 [salt.utils.extmods][INFO    ][22182] Loading cache from salt://_output, for base)
2017-09-25 15:57:01,068 [salt.fileclient  ][INFO    ][22182] Caching directory '_output/' for environment 'base'
2017-09-25 15:57:01,090 [salt.utils.extmods][INFO    ][22182] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-25 15:57:01,096 [salt.utils.extmods][INFO    ][22182] Syncing utils for environment 'base'
2017-09-25 15:57:01,097 [salt.utils.extmods][INFO    ][22182] Loading cache from salt://_utils, for base)
2017-09-25 15:57:01,097 [salt.fileclient  ][INFO    ][22182] Caching directory '_utils/' for environment 'base'
2017-09-25 15:57:01,137 [salt.utils.extmods][INFO    ][22182] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-25 15:57:01,142 [salt.utils.extmods][INFO    ][22182] Syncing log_handlers for environment 'base'
2017-09-25 15:57:01,143 [salt.utils.extmods][INFO    ][22182] Loading cache from salt://_log_handlers, for base)
2017-09-25 15:57:01,143 [salt.fileclient  ][INFO    ][22182] Caching directory '_log_handlers/' for environment 'base'
2017-09-25 15:57:01,513 [salt.utils.extmods][INFO    ][22182] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-25 15:57:01,519 [salt.utils.extmods][INFO    ][22182] Syncing proxy for environment 'base'
2017-09-25 15:57:01,519 [salt.utils.extmods][INFO    ][22182] Loading cache from salt://_proxy, for base)
2017-09-25 15:57:01,520 [salt.fileclient  ][INFO    ][22182] Caching directory '_proxy/' for environment 'base'
2017-09-25 15:57:01,550 [salt.utils.extmods][INFO    ][22182] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-25 15:57:01,555 [salt.utils.extmods][INFO    ][22182] Syncing engines for environment 'base'
2017-09-25 15:57:01,555 [salt.utils.extmods][INFO    ][22182] Loading cache from salt://_engines, for base)
2017-09-25 15:57:01,556 [salt.fileclient  ][INFO    ][22182] Caching directory '_engines/' for environment 'base'
2017-09-25 15:57:01,586 [salt.minion      ][INFO    ][22182] Returning information for job: 20170925155656298132
2017-09-25 16:08:54,396 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command test.ping with jid 20170925160854386303
2017-09-25 16:08:54,423 [salt.minion      ][INFO    ][22428] Starting a new job with PID 22428
2017-09-25 16:08:54,481 [salt.minion      ][INFO    ][22428] Returning information for job: 20170925160854386303
2017-09-25 16:13:39,626 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command state.sls with jid 20170925161339616954
2017-09-25 16:13:39,650 [salt.minion      ][INFO    ][22497] Starting a new job with PID 22497
2017-09-25 16:13:41,109 [salt.state       ][INFO    ][22497] Loading fresh modules for state activity
2017-09-25 16:13:41,151 [salt.fileclient  ][INFO    ][22497] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-25 16:13:41,176 [salt.fileclient  ][INFO    ][22497] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-25 16:13:41,211 [salt.fileclient  ][INFO    ][22497] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 16:13:41,636 [salt.state       ][INFO    ][22497] Running state [lsof] at time 16:13:41.636179
2017-09-25 16:13:41,637 [salt.state       ][INFO    ][22497] Executing state pkg.installed for lsof
2017-09-25 16:13:41,637 [salt.loaded.int.module.cmdmod][INFO    ][22497] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 16:13:42,009 [salt.state       ][INFO    ][22497] Package lsof is already installed
2017-09-25 16:13:42,009 [salt.state       ][INFO    ][22497] Completed state [lsof] at time 16:13:42.009274 duration_in_ms=373.094
2017-09-25 16:13:42,010 [salt.state       ][INFO    ][22497] Running state [keepalived] at time 16:13:42.009486
2017-09-25 16:13:42,010 [salt.state       ][INFO    ][22497] Executing state pkg.installed for keepalived
2017-09-25 16:13:42,030 [salt.loaded.int.module.cmdmod][INFO    ][22497] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-25 16:13:44,447 [salt.loaded.int.module.cmdmod][INFO    ][22497] 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-09-25 16:13:49,671 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925161349657642
2017-09-25 16:13:49,694 [salt.minion      ][INFO    ][23734] Starting a new job with PID 23734
2017-09-25 16:13:49,711 [salt.minion      ][INFO    ][23734] Returning information for job: 20170925161349657642
2017-09-25 16:13:53,871 [salt.loaded.int.module.cmdmod][INFO    ][22497] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 16:13:53,927 [salt.state       ][INFO    ][22497] 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-09-25 16:13:53,945 [salt.state       ][INFO    ][22497] Loading fresh modules for state activity
2017-09-25 16:13:53,970 [salt.state       ][INFO    ][22497] Completed state [keepalived] at time 16:13:53.969876 duration_in_ms=11960.388
2017-09-25 16:13:53,984 [salt.state       ][INFO    ][22497] Running state [/etc/keepalived/keepalived.conf] at time 16:13:53.983919
2017-09-25 16:13:53,985 [salt.state       ][INFO    ][22497] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-25 16:13:54,041 [salt.fileclient  ][INFO    ][22497] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-25 16:13:54,100 [salt.fileclient  ][INFO    ][22497] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-25 16:13:54,113 [salt.state       ][INFO    ][22497] File changed:
New file
2017-09-25 16:13:54,114 [salt.state       ][INFO    ][22497] Completed state [/etc/keepalived/keepalived.conf] at time 16:13:54.113705 duration_in_ms=129.786
2017-09-25 16:13:54,223 [salt.state       ][INFO    ][22497] Running state [keepalived] at time 16:13:54.222782
2017-09-25 16:13:54,223 [salt.state       ][INFO    ][22497] Executing state service.running for keepalived
2017-09-25 16:13:54,226 [salt.loaded.int.module.cmdmod][INFO    ][22497] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-25 16:13:54,244 [salt.loaded.int.module.cmdmod][INFO    ][22497] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-25 16:13:54,258 [salt.loaded.int.module.cmdmod][INFO    ][22497] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-25 16:13:54,274 [salt.loaded.int.module.cmdmod][INFO    ][22497] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-25 16:13:54,292 [salt.loaded.int.module.cmdmod][INFO    ][22497] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-25 16:13:54,373 [salt.loaded.int.module.cmdmod][INFO    ][22497] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-25 16:13:54,388 [salt.loaded.int.module.cmdmod][INFO    ][22497] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-25 16:13:54,403 [salt.loaded.int.module.cmdmod][INFO    ][22497] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-25 16:13:54,416 [salt.state       ][INFO    ][22497] {'keepalived': True}
2017-09-25 16:13:54,417 [salt.state       ][INFO    ][22497] Completed state [keepalived] at time 16:13:54.416508 duration_in_ms=193.726
2017-09-25 16:13:54,418 [salt.minion      ][INFO    ][22497] Returning information for job: 20170925161339616954
2017-09-25 16:14:09,533 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command pillar.get with jid 20170925161409520474
2017-09-25 16:14:09,557 [salt.minion      ][INFO    ][24042] Starting a new job with PID 24042
2017-09-25 16:14:09,566 [salt.minion      ][INFO    ][24042] Returning information for job: 20170925161409520474
2017-09-25 16:20:21,913 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command state.sls with jid 20170925162021902348
2017-09-25 16:20:21,938 [salt.minion      ][INFO    ][24161] Starting a new job with PID 24161
2017-09-25 16:20:24,402 [salt.state       ][INFO    ][24161] Loading fresh modules for state activity
2017-09-25 16:20:24,445 [salt.fileclient  ][INFO    ][24161] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-25 16:20:24,480 [salt.fileclient  ][INFO    ][24161] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-25 16:20:24,903 [salt.state       ][INFO    ][24161] Running state [attr] at time 16:20:24.902855
2017-09-25 16:20:24,903 [salt.state       ][INFO    ][24161] Executing state pkg.installed for attr
2017-09-25 16:20:24,904 [salt.loaded.int.module.cmdmod][INFO    ][24161] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 16:20:25,304 [salt.loaded.int.module.cmdmod][INFO    ][24161] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-25 16:20:27,480 [salt.loaded.int.module.cmdmod][INFO    ][24161] 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-09-25 16:20:30,842 [salt.loaded.int.module.cmdmod][INFO    ][24161] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 16:20:30,897 [salt.state       ][INFO    ][24161] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-25 16:20:30,915 [salt.state       ][INFO    ][24161] Loading fresh modules for state activity
2017-09-25 16:20:30,941 [salt.state       ][INFO    ][24161] Completed state [attr] at time 16:20:30.940671 duration_in_ms=6037.816
2017-09-25 16:20:30,968 [salt.state       ][INFO    ][24161] Running state [glusterfs-server] at time 16:20:30.968208
2017-09-25 16:20:30,969 [salt.state       ][INFO    ][24161] Executing state pkg.installed for glusterfs-server
2017-09-25 16:20:31,260 [salt.loaded.int.module.cmdmod][INFO    ][24161] 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-09-25 16:20:32,008 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925162031996197
2017-09-25 16:20:32,029 [salt.minion      ][INFO    ][25116] Starting a new job with PID 25116
2017-09-25 16:20:32,049 [salt.minion      ][INFO    ][25116] Returning information for job: 20170925162031996197
2017-09-25 16:20:42,066 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925162042054268
2017-09-25 16:20:42,087 [salt.minion      ][INFO    ][26926] Starting a new job with PID 26926
2017-09-25 16:20:42,105 [salt.minion      ][INFO    ][26926] Returning information for job: 20170925162042054268
2017-09-25 16:20:52,284 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command saltutil.find_job with jid 20170925162052269842
2017-09-25 16:20:52,306 [salt.minion      ][INFO    ][28306] Starting a new job with PID 28306
2017-09-25 16:20:52,328 [salt.minion      ][INFO    ][28306] Returning information for job: 20170925162052269842
2017-09-25 16:20:54,243 [salt.loaded.int.module.cmdmod][INFO    ][24161] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 16:20:54,280 [salt.state       ][INFO    ][24161] 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-09-25 16:20:54,296 [salt.state       ][INFO    ][24161] Loading fresh modules for state activity
2017-09-25 16:20:54,320 [salt.state       ][INFO    ][24161] Completed state [glusterfs-server] at time 16:20:54.319491 duration_in_ms=23351.283
2017-09-25 16:20:54,320 [salt.transport.ipc][ERROR   ][21780] Exception occurred while handling stream: [Errno 0] Success
2017-09-25 16:20:54,327 [salt.state       ][INFO    ][24161] Running state [bc] at time 16:20:54.327182
2017-09-25 16:20:54,327 [salt.state       ][INFO    ][24161] Executing state pkg.installed for bc
2017-09-25 16:20:54,602 [salt.loaded.int.module.cmdmod][INFO    ][24161] 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-09-25 16:20:58,051 [salt.loaded.int.module.cmdmod][INFO    ][24161] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 16:20:58,110 [salt.state       ][INFO    ][24161] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-25 16:20:58,125 [salt.state       ][INFO    ][24161] Loading fresh modules for state activity
2017-09-25 16:20:58,151 [salt.state       ][INFO    ][24161] Completed state [bc] at time 16:20:58.150944 duration_in_ms=3823.761
2017-09-25 16:20:58,253 [salt.state       ][INFO    ][24161] Running state [glusterfs-server] at time 16:20:58.252608
2017-09-25 16:20:58,253 [salt.state       ][INFO    ][24161] Executing state service.running for glusterfs-server
2017-09-25 16:20:58,255 [salt.loaded.int.module.cmdmod][INFO    ][24161] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-25 16:20:58,273 [salt.loaded.int.module.cmdmod][INFO    ][24161] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-25 16:20:58,288 [salt.loaded.int.module.cmdmod][INFO    ][24161] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-25 16:20:58,306 [salt.state       ][INFO    ][24161] The service glusterfs-server is already running
2017-09-25 16:20:58,306 [salt.state       ][INFO    ][24161] Completed state [glusterfs-server] at time 16:20:58.305954 duration_in_ms=53.345
2017-09-25 16:20:58,308 [salt.state       ][INFO    ][24161] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 16:20:58.307981
2017-09-25 16:20:58,308 [salt.state       ][INFO    ][24161] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-25 16:20:58,321 [salt.state       ][INFO    ][24161] File changed:
New file
2017-09-25 16:20:58,321 [salt.state       ][INFO    ][24161] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 16:20:58.320798 duration_in_ms=12.818
2017-09-25 16:20:58,321 [salt.state       ][INFO    ][24161] Running state [/srv/glusterfs/glance] at time 16:20:58.321012
2017-09-25 16:20:58,321 [salt.state       ][INFO    ][24161] Executing state file.directory for /srv/glusterfs/glance
2017-09-25 16:20:58,322 [salt.state       ][INFO    ][24161] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-25 16:20:58,322 [salt.state       ][INFO    ][24161] Completed state [/srv/glusterfs/glance] at time 16:20:58.322121 duration_in_ms=1.109
2017-09-25 16:20:58,322 [salt.state       ][INFO    ][24161] Running state [/srv/glusterfs/keystone-keys] at time 16:20:58.322320
2017-09-25 16:20:58,323 [salt.state       ][INFO    ][24161] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-25 16:20:58,323 [salt.state       ][INFO    ][24161] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-25 16:20:58,323 [salt.state       ][INFO    ][24161] Completed state [/srv/glusterfs/keystone-keys] at time 16:20:58.323214 duration_in_ms=0.893
2017-09-25 16:20:58,323 [salt.state       ][INFO    ][24161] Running state [/srv/glusterfs/nova_instances] at time 16:20:58.323418
2017-09-25 16:20:58,324 [salt.state       ][INFO    ][24161] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-25 16:20:58,324 [salt.state       ][INFO    ][24161] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-25 16:20:58,324 [salt.state       ][INFO    ][24161] Completed state [/srv/glusterfs/nova_instances] at time 16:20:58.324318 duration_in_ms=0.9
2017-09-25 16:20:58,325 [salt.state       ][INFO    ][24161] Running state [/srv/glusterfs/keystone-credential-keys] at time 16:20:58.324517
2017-09-25 16:20:58,325 [salt.state       ][INFO    ][24161] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-25 16:20:58,325 [salt.state       ][INFO    ][24161] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-25 16:20:58,325 [salt.state       ][INFO    ][24161] Completed state [/srv/glusterfs/keystone-credential-keys] at time 16:20:58.325403 duration_in_ms=0.885
2017-09-25 16:20:58,326 [salt.minion      ][INFO    ][24161] Returning information for job: 20170925162021902348
2017-09-25 16:21:00,784 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command test.ping with jid 20170925162100773668
2017-09-25 16:21:00,808 [salt.minion      ][INFO    ][28859] Starting a new job with PID 28859
2017-09-25 16:21:00,860 [salt.minion      ][INFO    ][28859] Returning information for job: 20170925162100773668
2017-09-25 16:21:48,160 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command state.sls with jid 20170925162148148496
2017-09-25 16:21:48,182 [salt.minion      ][INFO    ][29077] Starting a new job with PID 29077
2017-09-25 16:21:49,698 [salt.state       ][INFO    ][29077] Loading fresh modules for state activity
2017-09-25 16:21:49,740 [salt.fileclient  ][INFO    ][29077] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-25 16:21:49,799 [salt.fileclient  ][INFO    ][29077] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-25 16:21:49,898 [salt.fileclient  ][INFO    ][29077] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-25 16:21:49,921 [salt.fileclient  ][INFO    ][29077] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-25 16:21:50,233 [salt.state       ][INFO    ][29077] Running state [attr] at time 16:21:50.232666
2017-09-25 16:21:50,233 [salt.state       ][INFO    ][29077] Executing state pkg.installed for attr
2017-09-25 16:21:50,233 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-25 16:21:50,612 [salt.state       ][INFO    ][29077] Package attr is already installed
2017-09-25 16:21:50,612 [salt.state       ][INFO    ][29077] Completed state [attr] at time 16:21:50.612423 duration_in_ms=379.757
2017-09-25 16:21:50,613 [salt.state       ][INFO    ][29077] Running state [glusterfs-server] at time 16:21:50.612642
2017-09-25 16:21:50,613 [salt.state       ][INFO    ][29077] Executing state pkg.installed for glusterfs-server
2017-09-25 16:21:50,616 [salt.state       ][INFO    ][29077] Package glusterfs-server is already installed
2017-09-25 16:21:50,616 [salt.state       ][INFO    ][29077] Completed state [glusterfs-server] at time 16:21:50.615658 duration_in_ms=3.016
2017-09-25 16:21:50,616 [salt.state       ][INFO    ][29077] Running state [bc] at time 16:21:50.615813
2017-09-25 16:21:50,616 [salt.state       ][INFO    ][29077] Executing state pkg.installed for bc
2017-09-25 16:21:50,619 [salt.state       ][INFO    ][29077] Package bc is already installed
2017-09-25 16:21:50,619 [salt.state       ][INFO    ][29077] Completed state [bc] at time 16:21:50.618730 duration_in_ms=2.918
2017-09-25 16:21:50,620 [salt.state       ][INFO    ][29077] Running state [glusterfs-server] at time 16:21:50.619582
2017-09-25 16:21:50,620 [salt.state       ][INFO    ][29077] Executing state service.running for glusterfs-server
2017-09-25 16:21:50,620 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-25 16:21:50,637 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-25 16:21:50,723 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-25 16:21:50,753 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-25 16:21:50,766 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-25 16:21:50,784 [salt.state       ][INFO    ][29077] The service glusterfs-server is already running
2017-09-25 16:21:50,785 [salt.state       ][INFO    ][29077] Completed state [glusterfs-server] at time 16:21:50.784429 duration_in_ms=164.844
2017-09-25 16:21:50,787 [salt.state       ][INFO    ][29077] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 16:21:50.787191
2017-09-25 16:21:50,788 [salt.state       ][INFO    ][29077] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-25 16:21:50,800 [salt.state       ][INFO    ][29077] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-25 16:21:50,800 [salt.state       ][INFO    ][29077] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 16:21:50.800420 duration_in_ms=13.23
2017-09-25 16:21:50,801 [salt.state       ][INFO    ][29077] Running state [/srv/glusterfs/glance] at time 16:21:50.800762
2017-09-25 16:21:50,801 [salt.state       ][INFO    ][29077] Executing state file.directory for /srv/glusterfs/glance
2017-09-25 16:21:50,802 [salt.state       ][INFO    ][29077] Directory /srv/glusterfs/glance is in the correct state
2017-09-25 16:21:50,802 [salt.state       ][INFO    ][29077] Completed state [/srv/glusterfs/glance] at time 16:21:50.802032 duration_in_ms=1.27
2017-09-25 16:21:50,802 [salt.state       ][INFO    ][29077] Running state [/srv/glusterfs/keystone-keys] at time 16:21:50.802359
2017-09-25 16:21:50,803 [salt.state       ][INFO    ][29077] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-25 16:21:50,803 [salt.state       ][INFO    ][29077] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-25 16:21:50,804 [salt.state       ][INFO    ][29077] Completed state [/srv/glusterfs/keystone-keys] at time 16:21:50.803601 duration_in_ms=1.242
2017-09-25 16:21:50,804 [salt.state       ][INFO    ][29077] Running state [/srv/glusterfs/nova_instances] at time 16:21:50.803980
2017-09-25 16:21:50,804 [salt.state       ][INFO    ][29077] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-25 16:21:50,805 [salt.state       ][INFO    ][29077] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-25 16:21:50,805 [salt.state       ][INFO    ][29077] Completed state [/srv/glusterfs/nova_instances] at time 16:21:50.805246 duration_in_ms=1.265
2017-09-25 16:21:50,806 [salt.state       ][INFO    ][29077] Running state [/srv/glusterfs/keystone-credential-keys] at time 16:21:50.805570
2017-09-25 16:21:50,806 [salt.state       ][INFO    ][29077] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-25 16:21:50,807 [salt.state       ][INFO    ][29077] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-25 16:21:50,807 [salt.state       ][INFO    ][29077] Completed state [/srv/glusterfs/keystone-credential-keys] at time 16:21:50.806806 duration_in_ms=1.236
2017-09-25 16:21:50,906 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command ['git', '--version'] in directory '/root'
2017-09-25 16:21:51,029 [salt.state       ][INFO    ][29077] Running state [sleep 5] at time 16:21:51.028863
2017-09-25 16:21:51,029 [salt.state       ][INFO    ][29077] Executing state cmd.wait for sleep 5
2017-09-25 16:21:51,029 [salt.state       ][INFO    ][29077] No changes made for sleep 5
2017-09-25 16:21:51,030 [salt.state       ][INFO    ][29077] Completed state [sleep 5] at time 16:21:51.029513 duration_in_ms=0.65
2017-09-25 16:21:51,030 [salt.state       ][INFO    ][29077] Running state [10.167.4.141] at time 16:21:51.029932
2017-09-25 16:21:51,030 [salt.state       ][INFO    ][29077] Executing state glusterfs.peered for 10.167.4.141
2017-09-25 16:21:51,030 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:51,047 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:51,153 [salt.state       ][INFO    ][29077] Host 10.167.4.141 already peered
2017-09-25 16:21:51,154 [salt.state       ][INFO    ][29077] Completed state [10.167.4.141] at time 16:21:51.153550 duration_in_ms=123.616
2017-09-25 16:21:51,160 [salt.state       ][INFO    ][29077] Running state [10.167.4.142] at time 16:21:51.159521
2017-09-25 16:21:51,160 [salt.state       ][INFO    ][29077] Executing state glusterfs.peered for 10.167.4.142
2017-09-25 16:21:51,161 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:51,179 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:51,292 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:51,309 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:51,418 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:51,437 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:51,547 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:51,561 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:51,666 [salt.state       ][INFO    ][29077] {'new': {'10.167.4.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': ['10.167.4.142']}, 'old': {'10.167.4.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': []}}
2017-09-25 16:21:51,667 [salt.state       ][INFO    ][29077] Completed state [10.167.4.142] at time 16:21:51.666627 duration_in_ms=507.106
2017-09-25 16:21:51,672 [salt.state       ][INFO    ][29077] Running state [10.167.4.143] at time 16:21:51.672061
2017-09-25 16:21:51,673 [salt.state       ][INFO    ][29077] Executing state glusterfs.peered for 10.167.4.143
2017-09-25 16:21:51,673 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:51,690 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:51,800 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:51,816 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:51,922 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:51,939 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:52,045 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:52,063 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:52,174 [salt.state       ][INFO    ][29077] Peering with localhost is not needed
2017-09-25 16:21:52,174 [salt.state       ][INFO    ][29077] Completed state [10.167.4.143] at time 16:21:52.174392 duration_in_ms=502.33
2017-09-25 16:21:52,176 [salt.state       ][INFO    ][29077] Running state [glance] at time 16:21:52.176379
2017-09-25 16:21:52,177 [salt.state       ][INFO    ][29077] Executing state glusterfs.created for glance
2017-09-25 16:21:52,178 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:52,195 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:52,297 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:52,314 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:52,425 [salt.state       ][INFO    ][29077] Volume glance already exists and is started.
2017-09-25 16:21:52,426 [salt.state       ][INFO    ][29077] Completed state [glance] at time 16:21:52.425878 duration_in_ms=249.499
2017-09-25 16:21:52,431 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 16:21:52.430797
2017-09-25 16:21:52,431 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-25 16:21:52,432 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-25 16:21:52,536 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:52,537 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 16:21:52.536581 duration_in_ms=105.783
2017-09-25 16:21:52,538 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 16:21:52.537570
2017-09-25 16:21:52,538 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-25 16:21:52,539 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-25 16:21:52,648 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:52,649 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 16:21:52.648900 duration_in_ms=111.329
2017-09-25 16:21:52,650 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 16:21:52.650040
2017-09-25 16:21:52,651 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-25 16:21:52,652 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-25 16:21:52,756 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:52,757 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 16:21:52.756840 duration_in_ms=106.8
2017-09-25 16:21:52,758 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 16:21:52.757965
2017-09-25 16:21:52,759 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-25 16:21:52,760 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-25 16:21:52,863 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:52,864 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 16:21:52.863742 duration_in_ms=105.777
2017-09-25 16:21:52,865 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 16:21:52.864864
2017-09-25 16:21:52,865 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-25 16:21:52,866 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-25 16:21:52,969 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:52,969 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 16:21:52.969021 duration_in_ms=104.156
2017-09-25 16:21:52,972 [salt.state       ][INFO    ][29077] Running state [glance] at time 16:21:52.971579
2017-09-25 16:21:52,972 [salt.state       ][INFO    ][29077] Executing state glusterfs.started for glance
2017-09-25 16:21:52,973 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:52,990 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:53,095 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:53,113 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:53,218 [salt.state       ][INFO    ][29077] Volume glance is already started
2017-09-25 16:21:53,219 [salt.state       ][INFO    ][29077] Completed state [glance] at time 16:21:53.218814 duration_in_ms=247.235
2017-09-25 16:21:53,221 [salt.state       ][INFO    ][29077] Running state [keystone-keys] at time 16:21:53.220721
2017-09-25 16:21:53,221 [salt.state       ][INFO    ][29077] Executing state glusterfs.created for keystone-keys
2017-09-25 16:21:53,222 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:53,240 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:53,342 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:53,359 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:53,461 [salt.state       ][INFO    ][29077] Volume keystone-keys already exists and is started.
2017-09-25 16:21:53,462 [salt.state       ][INFO    ][29077] Completed state [keystone-keys] at time 16:21:53.461851 duration_in_ms=241.129
2017-09-25 16:21:53,470 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 16:21:53.469517
2017-09-25 16:21:53,470 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-25 16:21:53,471 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-25 16:21:53,580 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:53,580 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 16:21:53.579983 duration_in_ms=110.466
2017-09-25 16:21:53,581 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 16:21:53.580878
2017-09-25 16:21:53,581 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-25 16:21:53,582 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-25 16:21:53,683 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:53,684 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 16:21:53.683593 duration_in_ms=102.714
2017-09-25 16:21:53,685 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 16:21:53.684716
2017-09-25 16:21:53,685 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-25 16:21:53,686 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-25 16:21:53,787 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:53,788 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 16:21:53.787665 duration_in_ms=102.948
2017-09-25 16:21:53,789 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 16:21:53.788806
2017-09-25 16:21:53,789 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-25 16:21:53,790 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-25 16:21:53,891 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:53,891 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 16:21:53.891177 duration_in_ms=102.369
2017-09-25 16:21:53,892 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 16:21:53.892365
2017-09-25 16:21:53,893 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-25 16:21:53,894 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-25 16:21:53,997 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:53,998 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 16:21:53.997844 duration_in_ms=105.479
2017-09-25 16:21:54,000 [salt.state       ][INFO    ][29077] Running state [keystone-keys] at time 16:21:54.000302
2017-09-25 16:21:54,001 [salt.state       ][INFO    ][29077] Executing state glusterfs.started for keystone-keys
2017-09-25 16:21:54,002 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:54,016 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:54,114 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:54,131 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:54,248 [salt.state       ][INFO    ][29077] Volume keystone-keys is already started
2017-09-25 16:21:54,248 [salt.state       ][INFO    ][29077] Completed state [keystone-keys] at time 16:21:54.248326 duration_in_ms=248.023
2017-09-25 16:21:54,251 [salt.state       ][INFO    ][29077] Running state [nova_instances] at time 16:21:54.250852
2017-09-25 16:21:54,251 [salt.state       ][INFO    ][29077] Executing state glusterfs.created for nova_instances
2017-09-25 16:21:54,252 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:54,269 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:54,373 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:54,391 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:54,504 [salt.state       ][INFO    ][29077] Volume nova_instances already exists and is started.
2017-09-25 16:21:54,505 [salt.state       ][INFO    ][29077] Completed state [nova_instances] at time 16:21:54.504750 duration_in_ms=253.897
2017-09-25 16:21:54,513 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 16:21:54.512620
2017-09-25 16:21:54,513 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-25 16:21:54,514 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-25 16:21:54,620 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:54,621 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 16:21:54.620857 duration_in_ms=108.236
2017-09-25 16:21:54,622 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 16:21:54.621911
2017-09-25 16:21:54,622 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-09-25 16:21:54,623 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-25 16:21:54,728 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:54,728 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 16:21:54.728191 duration_in_ms=106.279
2017-09-25 16:21:54,729 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 16:21:54.729275
2017-09-25 16:21:54,730 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-09-25 16:21:54,731 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-25 16:21:54,838 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:54,838 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 16:21:54.838378 duration_in_ms=109.102
2017-09-25 16:21:54,840 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 16:21:54.839520
2017-09-25 16:21:54,840 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-09-25 16:21:54,841 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-09-25 16:21:54,945 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:54,946 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 16:21:54.945677 duration_in_ms=106.156
2017-09-25 16:21:54,947 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 16:21:54.946780
2017-09-25 16:21:54,947 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-25 16:21:54,948 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-25 16:21:55,053 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:55,054 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 16:21:55.053908 duration_in_ms=107.128
2017-09-25 16:21:55,057 [salt.state       ][INFO    ][29077] Running state [nova_instances] at time 16:21:55.056530
2017-09-25 16:21:55,057 [salt.state       ][INFO    ][29077] Executing state glusterfs.started for nova_instances
2017-09-25 16:21:55,058 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:55,075 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:55,174 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:55,190 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:55,299 [salt.state       ][INFO    ][29077] Volume nova_instances is already started
2017-09-25 16:21:55,300 [salt.state       ][INFO    ][29077] Completed state [nova_instances] at time 16:21:55.299968 duration_in_ms=243.438
2017-09-25 16:21:55,302 [salt.state       ][INFO    ][29077] Running state [keystone-credential-keys] at time 16:21:55.302136
2017-09-25 16:21:55,303 [salt.state       ][INFO    ][29077] Executing state glusterfs.created for keystone-credential-keys
2017-09-25 16:21:55,304 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:55,321 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:55,431 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:55,449 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:55,562 [salt.state       ][INFO    ][29077] Volume keystone-credential-keys already exists and is started.
2017-09-25 16:21:55,563 [salt.state       ][INFO    ][29077] Completed state [keystone-credential-keys] at time 16:21:55.562868 duration_in_ms=260.731
2017-09-25 16:21:55,570 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 16:21:55.570333
2017-09-25 16:21:55,571 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-25 16:21:55,572 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-25 16:21:55,671 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:55,672 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 16:21:55.671700 duration_in_ms=101.366
2017-09-25 16:21:55,673 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 16:21:55.672834
2017-09-25 16:21:55,673 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-25 16:21:55,674 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-25 16:21:55,778 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:55,778 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 16:21:55.778034 duration_in_ms=105.199
2017-09-25 16:21:55,779 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 16:21:55.779101
2017-09-25 16:21:55,780 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-25 16:21:55,781 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-25 16:21:55,880 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:55,880 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 16:21:55.880230 duration_in_ms=101.127
2017-09-25 16:21:55,882 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 16:21:55.881533
2017-09-25 16:21:55,882 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-25 16:21:55,883 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-25 16:21:55,993 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:55,994 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 16:21:55.993434 duration_in_ms=111.9
2017-09-25 16:21:55,995 [salt.state       ][INFO    ][29077] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 16:21:55.994560
2017-09-25 16:21:55,995 [salt.state       ][INFO    ][29077] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-25 16:21:55,996 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-25 16:21:56,105 [salt.state       ][INFO    ][29077] unless execution succeeded
2017-09-25 16:21:56,105 [salt.state       ][INFO    ][29077] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 16:21:56.105215 duration_in_ms=110.654
2017-09-25 16:21:56,108 [salt.state       ][INFO    ][29077] Running state [keystone-credential-keys] at time 16:21:56.107766
2017-09-25 16:21:56,108 [salt.state       ][INFO    ][29077] Executing state glusterfs.started for keystone-credential-keys
2017-09-25 16:21:56,109 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:56,127 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:56,235 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --version' in directory '/root'
2017-09-25 16:21:56,254 [salt.loaded.int.module.cmdmod][INFO    ][29077] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-25 16:21:56,367 [salt.state       ][INFO    ][29077] Volume keystone-credential-keys is already started
2017-09-25 16:21:56,367 [salt.state       ][INFO    ][29077] Completed state [keystone-credential-keys] at time 16:21:56.367133 duration_in_ms=259.366
2017-09-25 16:21:56,371 [salt.minion      ][INFO    ][29077] Returning information for job: 20170925162148148496
2017-09-25 16:22:04,665 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command test.ping with jid 20170925162204652491
2017-09-25 16:22:04,686 [salt.minion      ][INFO    ][29506] Starting a new job with PID 29506
2017-09-25 16:22:04,740 [salt.minion      ][INFO    ][29506] Returning information for job: 20170925162204652491
2017-09-25 16:22:05,263 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command cmd.run with jid 20170925162205253031
2017-09-25 16:22:05,285 [salt.minion      ][INFO    ][29511] Starting a new job with PID 29511
2017-09-25 16:22:05,291 [salt.loaded.int.module.cmdmod][INFO    ][29511] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-25 16:22:05,519 [salt.minion      ][INFO    ][29511] Returning information for job: 20170925162205253031
2017-09-25 16:55:03,326 [salt.utils.schedule][INFO    ][21780] Running scheduled job: __mine_interval
2017-09-25 17:47:43,114 [salt.minion      ][INFO    ][21780] User sudo_ubuntu Executing command cp.push_dir with jid 20170925174743103951
2017-09-25 17:47:43,140 [salt.minion      ][INFO    ][30509] Starting a new job with PID 30509
