2017-09-15 02:07:56,535 [salt.utils       ][ERROR   ][3932] DNS lookup or connection check of 'salt' failed.
2017-09-15 02:07:56,535 [salt.minion      ][ERROR   ][3932] Master hostname: 'salt' not found or not responsive. Retrying in 30 seconds
2017-09-15 02:07:58,321 [salt.utils.parsers][WARNING ][3932] Minion received a SIGTERM. Exiting.
2017-09-15 02:08:38,938 [salt.minion      ][ERROR   ][4056] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2017-09-15 02:09:27,439 [salt.crypt       ][ERROR   ][4056] The Salt Master has cached the public key for this node, this salt minion will wait for 10 seconds before attempting to re-authenticate
2017-09-15 02:12:06,551 [salt.utils.parsers][WARNING ][16238] Minion received a SIGTERM. Exiting.
2017-09-15 02:12:20,186 [py.warnings      ][WARNING ][23630] /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-15 02:12:50,935 [salt.loaded.int.states.file][WARNING ][23630] State for file: /etc/pki/ca/salt_master_ca/ca.crt - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2017-09-15 02:13:04,795 [salt.loaded.int.module.cmdmod][ERROR   ][23630] 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-15 02:13:08,993 [salt.loaded.int.module.cmdmod][INFO    ][30025] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-15 02:13:09,000 [salt.loaded.int.module.cmdmod][INFO    ][30025] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-15 02:13:09,008 [salt.loaded.int.module.cmdmod][INFO    ][30025] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-15 02:13:09,029 [salt.utils.parsers][WARNING ][23317] Minion received a SIGTERM. Exiting.
2017-09-15 02:13:09,936 [salt.cli.daemons ][INFO    ][30131] Setting up the Salt Minion "cfg01.baremetal-mcp-ocata-odl-ha.local"
2017-09-15 02:13:10,013 [salt.cli.daemons ][INFO    ][30131] Starting up the Salt Minion
2017-09-15 02:13:10,014 [salt.utils.event ][INFO    ][30131] Starting pull socket on /var/run/salt/minion/minion_event_d39b300263_pull.ipc
2017-09-15 02:13:10,437 [salt.minion      ][INFO    ][30131] Creating minion process manager
2017-09-15 02:13:11,217 [salt.loader.10.20.0.2.int.module.cmdmod][INFO    ][30131] Executing command ['date', '+%z'] in directory '/root'
2017-09-15 02:13:11,230 [salt.utils.schedule][INFO    ][30131] Updating job settings for scheduled job: __mine_interval
2017-09-15 02:13:11,235 [salt.minion      ][INFO    ][30131] Added mine.update to scheduler
2017-09-15 02:13:11,249 [salt.minion      ][INFO    ][30131] Minion is starting as user 'root'
2017-09-15 02:13:11,265 [salt.minion      ][INFO    ][30131] Minion is ready to receive requests!
2017-09-15 02:13:12,266 [salt.utils.schedule][INFO    ][30131] Running scheduled job: __mine_interval
2017-09-15 02:13:19,481 [salt.minion      ][INFO    ][30131] User sudo_ubuntu Executing command saltutil.find_job with jid 20170915021319465833
2017-09-15 02:13:19,510 [salt.minion      ][INFO    ][30228] Starting a new job with PID 30228
2017-09-15 02:13:19,530 [salt.minion      ][INFO    ][30228] Returning information for job: 20170915021319465833
2017-09-15 02:13:29,613 [salt.minion      ][INFO    ][30131] User sudo_ubuntu Executing command saltutil.find_job with jid 20170915021329600629
2017-09-15 02:13:29,642 [salt.minion      ][INFO    ][30237] Starting a new job with PID 30237
2017-09-15 02:13:29,661 [salt.minion      ][INFO    ][30237] Returning information for job: 20170915021329600629
2017-09-15 02:13:40,324 [salt.minion      ][INFO    ][30131] User sudo_ubuntu Executing command state.apply with jid 20170915021340309496
2017-09-15 02:13:40,351 [salt.minion      ][INFO    ][30296] Starting a new job with PID 30296
2017-09-15 02:13:42,945 [salt.state       ][INFO    ][30296] Loading fresh modules for state activity
2017-09-15 02:13:43,923 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command 'reclass --version' in directory '/root'
2017-09-15 02:13:44,135 [py.warnings      ][WARNING ][30296] /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-15 02:13:44,135 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command 'salt-minion --version' in directory '/root'
2017-09-15 02:13:44,402 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command 'salt --version' in directory '/root'
2017-09-15 02:13:44,932 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command 'reclass --version' in directory '/root'
2017-09-15 02:13:45,118 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command 'salt-minion --version' in directory '/root'
2017-09-15 02:13:45,300 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command 'salt --version' in directory '/root'
2017-09-15 02:13:46,431 [salt.state       ][INFO    ][30296] Running state [salt-master] at time 02:13:46.431562
2017-09-15 02:13:46,446 [salt.state       ][INFO    ][30296] Executing state pkg.installed for salt-master
2017-09-15 02:13:46,447 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 02:13:46,728 [salt.state       ][INFO    ][30296] Package salt-master is already installed
2017-09-15 02:13:46,728 [salt.state       ][INFO    ][30296] Completed state [salt-master] at time 02:13:46.728516 duration_in_ms=296.954
2017-09-15 02:13:46,731 [salt.state       ][INFO    ][30296] Running state [/etc/salt/master.d/master.conf] at time 02:13:46.731011
2017-09-15 02:13:46,731 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/salt/master.d/master.conf
2017-09-15 02:13:46,840 [salt.state       ][INFO    ][30296] File /etc/salt/master.d/master.conf is in the correct state
2017-09-15 02:13:46,840 [salt.state       ][INFO    ][30296] Completed state [/etc/salt/master.d/master.conf] at time 02:13:46.840298 duration_in_ms=109.287
2017-09-15 02:13:46,840 [salt.state       ][INFO    ][30296] Running state [/etc/salt/master.d/_acl.conf] at time 02:13:46.840960
2017-09-15 02:13:46,841 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/salt/master.d/_acl.conf
2017-09-15 02:13:46,891 [salt.state       ][INFO    ][30296] File /etc/salt/master.d/_acl.conf is in the correct state
2017-09-15 02:13:46,891 [salt.state       ][INFO    ][30296] Completed state [/etc/salt/master.d/_acl.conf] at time 02:13:46.891778 duration_in_ms=50.818
2017-09-15 02:13:46,892 [salt.state       ][INFO    ][30296] Running state [/etc/salt/master.d/_peer.conf] at time 02:13:46.892371
2017-09-15 02:13:46,892 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/salt/master.d/_peer.conf
2017-09-15 02:13:46,948 [salt.state       ][INFO    ][30296] File /etc/salt/master.d/_peer.conf is in the correct state
2017-09-15 02:13:46,948 [salt.state       ][INFO    ][30296] Completed state [/etc/salt/master.d/_peer.conf] at time 02:13:46.948803 duration_in_ms=56.432
2017-09-15 02:13:46,950 [salt.state       ][INFO    ][30296] Running state [salt-master] at time 02:13:46.950673
2017-09-15 02:13:46,950 [salt.state       ][INFO    ][30296] Executing state service.running for salt-master
2017-09-15 02:13:46,951 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['systemctl', 'status', 'salt-master.service', '-n', '0'] in directory '/root'
2017-09-15 02:13:46,980 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['systemctl', 'is-active', 'salt-master.service'] in directory '/root'
2017-09-15 02:13:46,993 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['systemctl', 'is-enabled', 'salt-master.service'] in directory '/root'
2017-09-15 02:13:47,006 [salt.state       ][INFO    ][30296] The service salt-master is already running
2017-09-15 02:13:47,007 [salt.state       ][INFO    ][30296] Completed state [salt-master] at time 02:13:47.007206 duration_in_ms=56.532
2017-09-15 02:13:47,008 [salt.state       ][INFO    ][30296] Running state [/srv/salt/env] at time 02:13:47.008014
2017-09-15 02:13:47,008 [salt.state       ][INFO    ][30296] Executing state file.directory for /srv/salt/env
2017-09-15 02:13:47,010 [salt.state       ][INFO    ][30296] Directory /srv/salt/env is in the correct state
2017-09-15 02:13:47,010 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/env] at time 02:13:47.010878 duration_in_ms=2.865
2017-09-15 02:13:47,013 [salt.state       ][INFO    ][30296] Running state [salt] at time 02:13:47.012960
2017-09-15 02:13:47,013 [salt.state       ][INFO    ][30296] Executing state user.present for salt
2017-09-15 02:13:47,015 [salt.state       ][INFO    ][30296] User salt is present and up to date
2017-09-15 02:13:47,016 [salt.state       ][INFO    ][30296] Completed state [salt] at time 02:13:47.016088 duration_in_ms=3.128
2017-09-15 02:13:47,018 [salt.state       ][INFO    ][30296] Running state [/var/tmp/salt] at time 02:13:47.018121
2017-09-15 02:13:47,018 [salt.state       ][INFO    ][30296] Executing state file.directory for /var/tmp/salt
2017-09-15 02:13:47,020 [salt.state       ][INFO    ][30296] Directory /var/tmp/salt is in the correct state
2017-09-15 02:13:47,020 [salt.state       ][INFO    ][30296] Completed state [/var/tmp/salt] at time 02:13:47.020577 duration_in_ms=2.456
2017-09-15 02:13:47,021 [salt.state       ][INFO    ][30296] Running state [/etc/sudoers.d/90-salt-user-salt] at time 02:13:47.021268
2017-09-15 02:13:47,021 [salt.state       ][INFO    ][30296] Executing state file.absent for /etc/sudoers.d/90-salt-user-salt
2017-09-15 02:13:47,022 [salt.state       ][INFO    ][30296] File /etc/sudoers.d/90-salt-user-salt is not present
2017-09-15 02:13:47,023 [salt.state       ][INFO    ][30296] Completed state [/etc/sudoers.d/90-salt-user-salt] at time 02:13:47.023069 duration_in_ms=1.801
2017-09-15 02:13:47,023 [salt.state       ][INFO    ][30296] Running state [root] at time 02:13:47.023647
2017-09-15 02:13:47,024 [salt.state       ][INFO    ][30296] Executing state user.present for root
2017-09-15 02:13:47,025 [salt.state       ][INFO    ][30296] User root is present and up to date
2017-09-15 02:13:47,026 [salt.state       ][INFO    ][30296] Completed state [root] at time 02:13:47.026331 duration_in_ms=2.683
2017-09-15 02:13:47,028 [salt.state       ][INFO    ][30296] Running state [/root] at time 02:13:47.027984
2017-09-15 02:13:47,028 [salt.state       ][INFO    ][30296] Executing state file.directory for /root
2017-09-15 02:13:47,029 [salt.state       ][INFO    ][30296] Directory /root is in the correct state
2017-09-15 02:13:47,030 [salt.state       ][INFO    ][30296] Completed state [/root] at time 02:13:47.030346 duration_in_ms=2.362
2017-09-15 02:13:47,030 [salt.state       ][INFO    ][30296] Running state [/etc/sudoers.d/90-salt-user-root] at time 02:13:47.030948
2017-09-15 02:13:47,031 [salt.state       ][INFO    ][30296] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2017-09-15 02:13:47,032 [salt.state       ][INFO    ][30296] File /etc/sudoers.d/90-salt-user-root is not present
2017-09-15 02:13:47,032 [salt.state       ][INFO    ][30296] Completed state [/etc/sudoers.d/90-salt-user-root] at time 02:13:47.032642 duration_in_ms=1.693
2017-09-15 02:13:47,033 [salt.state       ][INFO    ][30296] Running state [ubuntu] at time 02:13:47.033260
2017-09-15 02:13:47,033 [salt.state       ][INFO    ][30296] Executing state user.present for ubuntu
2017-09-15 02:13:47,035 [salt.state       ][INFO    ][30296] User ubuntu is present and up to date
2017-09-15 02:13:47,035 [salt.state       ][INFO    ][30296] Completed state [ubuntu] at time 02:13:47.035902 duration_in_ms=2.642
2017-09-15 02:13:47,037 [salt.state       ][INFO    ][30296] Running state [/home/ubuntu] at time 02:13:47.037526
2017-09-15 02:13:47,038 [salt.state       ][INFO    ][30296] Executing state file.directory for /home/ubuntu
2017-09-15 02:13:47,039 [salt.state       ][INFO    ][30296] Directory /home/ubuntu is in the correct state
2017-09-15 02:13:47,039 [salt.state       ][INFO    ][30296] Completed state [/home/ubuntu] at time 02:13:47.039802 duration_in_ms=2.276
2017-09-15 02:13:47,041 [salt.state       ][INFO    ][30296] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 02:13:47.041200
2017-09-15 02:13:47,041 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2017-09-15 02:13:47,062 [salt.state       ][INFO    ][30296] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2017-09-15 02:13:47,062 [salt.state       ][INFO    ][30296] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 02:13:47.062752 duration_in_ms=21.551
2017-09-15 02:13:47,063 [salt.state       ][INFO    ][30296] Running state [git-core] at time 02:13:47.063302
2017-09-15 02:13:47,063 [salt.state       ][INFO    ][30296] Executing state pkg.installed for git-core
2017-09-15 02:13:47,071 [salt.state       ][INFO    ][30296] Package git-core is already installed
2017-09-15 02:13:47,072 [salt.state       ][INFO    ][30296] Completed state [git-core] at time 02:13:47.072376 duration_in_ms=9.074
2017-09-15 02:13:47,073 [salt.state       ][INFO    ][30296] Running state [/usr/share/salt-formulas/env/_grains] at time 02:13:47.072960
2017-09-15 02:13:47,073 [salt.state       ][INFO    ][30296] Executing state file.directory for /usr/share/salt-formulas/env/_grains
2017-09-15 02:13:47,074 [salt.state       ][INFO    ][30296] Directory /usr/share/salt-formulas/env/_grains is in the correct state
2017-09-15 02:13:47,074 [salt.state       ][INFO    ][30296] Completed state [/usr/share/salt-formulas/env/_grains] at time 02:13:47.074871 duration_in_ms=1.912
2017-09-15 02:13:47,075 [salt.state       ][INFO    ][30296] Running state [/usr/share/salt-formulas/env/_modules] at time 02:13:47.075395
2017-09-15 02:13:47,075 [salt.state       ][INFO    ][30296] Executing state file.directory for /usr/share/salt-formulas/env/_modules
2017-09-15 02:13:47,076 [salt.state       ][INFO    ][30296] Directory /usr/share/salt-formulas/env/_modules is in the correct state
2017-09-15 02:13:47,077 [salt.state       ][INFO    ][30296] Completed state [/usr/share/salt-formulas/env/_modules] at time 02:13:47.077368 duration_in_ms=1.972
2017-09-15 02:13:47,077 [salt.state       ][INFO    ][30296] Running state [/usr/share/salt-formulas/env/_formulas] at time 02:13:47.077915
2017-09-15 02:13:47,078 [salt.state       ][INFO    ][30296] Executing state file.directory for /usr/share/salt-formulas/env/_formulas
2017-09-15 02:13:47,079 [salt.state       ][INFO    ][30296] Directory /usr/share/salt-formulas/env/_formulas is in the correct state
2017-09-15 02:13:47,079 [salt.state       ][INFO    ][30296] Completed state [/usr/share/salt-formulas/env/_formulas] at time 02:13:47.079822 duration_in_ms=1.907
2017-09-15 02:13:47,080 [salt.state       ][INFO    ][30296] Running state [/usr/share/salt-formulas/env/_states] at time 02:13:47.080449
2017-09-15 02:13:47,081 [salt.state       ][INFO    ][30296] Executing state file.directory for /usr/share/salt-formulas/env/_states
2017-09-15 02:13:47,081 [salt.state       ][INFO    ][30296] Directory /usr/share/salt-formulas/env/_states is in the correct state
2017-09-15 02:13:47,082 [salt.state       ][INFO    ][30296] Completed state [/usr/share/salt-formulas/env/_states] at time 02:13:47.082392 duration_in_ms=1.943
2017-09-15 02:13:47,083 [salt.state       ][INFO    ][30296] Running state [/srv/salt/env/prd] at time 02:13:47.083803
2017-09-15 02:13:47,084 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/env/prd
2017-09-15 02:13:47,086 [salt.state       ][INFO    ][30296] Symlink /srv/salt/env/prd is present and owned by root:root
2017-09-15 02:13:47,086 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/env/prd] at time 02:13:47.086569 duration_in_ms=2.767
2017-09-15 02:13:47,087 [salt.state       ][INFO    ][30296] Running state [salt_master_prd_pkg_formulas] at time 02:13:47.087106
2017-09-15 02:13:47,087 [salt.state       ][INFO    ][30296] Executing state pkg.latest for salt_master_prd_pkg_formulas
2017-09-15 02:13:47,100 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-maas'] in directory '/root'
2017-09-15 02:13:47,154 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-grafana'] in directory '/root'
2017-09-15 02:13:47,205 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-xtrabackup'] in directory '/root'
2017-09-15 02:13:47,244 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-docker'] in directory '/root'
2017-09-15 02:13:47,299 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-heat'] in directory '/root'
2017-09-15 02:13:47,392 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-reclass'] in directory '/root'
2017-09-15 02:13:47,486 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-redis'] in directory '/root'
2017-09-15 02:13:47,544 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-nova'] in directory '/root'
2017-09-15 02:13:47,648 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-iptables'] in directory '/root'
2017-09-15 02:13:47,689 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-murano'] in directory '/root'
2017-09-15 02:13:47,726 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-glusterfs'] in directory '/root'
2017-09-15 02:13:47,766 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-backupninja'] in directory '/root'
2017-09-15 02:13:47,814 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-kubernetes'] in directory '/root'
2017-09-15 02:13:47,928 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-linux'] in directory '/root'
2017-09-15 02:13:48,019 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-git'] in directory '/root'
2017-09-15 02:13:48,059 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-supervisor'] in directory '/root'
2017-09-15 02:13:48,096 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-aptly'] in directory '/root'
2017-09-15 02:13:48,137 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-gerrit'] in directory '/root'
2017-09-15 02:13:48,177 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-cassandra'] in directory '/root'
2017-09-15 02:13:48,214 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-aptcacher'] in directory '/root'
2017-09-15 02:13:48,250 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-glance'] in directory '/root'
2017-09-15 02:13:48,318 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-heka'] in directory '/root'
2017-09-15 02:13:48,386 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-keystone'] in directory '/root'
2017-09-15 02:13:48,464 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ntp'] in directory '/root'
2017-09-15 02:13:48,505 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-memcached'] in directory '/root'
2017-09-15 02:13:48,547 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-aodh'] in directory '/root'
2017-09-15 02:13:48,588 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-python'] in directory '/root'
2017-09-15 02:13:48,624 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-collectd'] in directory '/root'
2017-09-15 02:13:48,681 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-neutron'] in directory '/root'
2017-09-15 02:13:48,760 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-apache'] in directory '/root'
2017-09-15 02:13:48,805 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ceilometer'] in directory '/root'
2017-09-15 02:13:48,866 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-elasticsearch'] in directory '/root'
2017-09-15 02:13:48,909 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-powerdns'] in directory '/root'
2017-09-15 02:13:48,945 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-sensu'] in directory '/root'
2017-09-15 02:13:48,998 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-libvirt'] in directory '/root'
2017-09-15 02:13:49,040 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-sahara'] in directory '/root'
2017-09-15 02:13:49,074 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-openssh'] in directory '/root'
2017-09-15 02:13:49,120 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-statsd'] in directory '/root'
2017-09-15 02:13:49,159 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-mongodb'] in directory '/root'
2017-09-15 02:13:49,194 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-kibana'] in directory '/root'
2017-09-15 02:13:49,240 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-sphinx'] in directory '/root'
2017-09-15 02:13:49,276 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-freeipa'] in directory '/root'
2017-09-15 02:13:49,310 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-octavia'] in directory '/root'
2017-09-15 02:13:49,347 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-bind'] in directory '/root'
2017-09-15 02:13:49,383 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-salt'] in directory '/root'
2017-09-15 02:13:49,448 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-etcd'] in directory '/root'
2017-09-15 02:13:49,494 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-devops-portal'] in directory '/root'
2017-09-15 02:13:49,529 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-postgresql'] in directory '/root'
2017-09-15 02:13:49,579 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-nginx'] in directory '/root'
2017-09-15 02:13:49,620 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-mysql'] in directory '/root'
2017-09-15 02:13:49,658 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ceph'] in directory '/root'
2017-09-15 02:13:49,702 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-horizon'] in directory '/root'
2017-09-15 02:13:49,764 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-haproxy'] in directory '/root'
2017-09-15 02:13:49,812 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-java'] in directory '/root'
2017-09-15 02:13:49,847 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-billometer'] in directory '/root'
2017-09-15 02:13:49,882 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-telegraf'] in directory '/root'
2017-09-15 02:13:49,929 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-designate'] in directory '/root'
2017-09-15 02:13:49,966 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-keepalived'] in directory '/root'
2017-09-15 02:13:50,006 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-rundeck'] in directory '/root'
2017-09-15 02:13:50,044 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ccp'] in directory '/root'
2017-09-15 02:13:50,077 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-cinder'] in directory '/root'
2017-09-15 02:13:50,147 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-rabbitmq'] in directory '/root'
2017-09-15 02:13:50,188 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-openldap'] in directory '/root'
2017-09-15 02:13:50,221 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-influxdb'] in directory '/root'
2017-09-15 02:13:50,259 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-helm'] in directory '/root'
2017-09-15 02:13:50,298 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-opencontrail'] in directory '/root'
2017-09-15 02:13:50,366 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-jenkins'] in directory '/root'
2017-09-15 02:13:50,405 [salt.minion      ][INFO    ][30131] User sudo_ubuntu Executing command saltutil.find_job with jid 20170915021350395831
2017-09-15 02:13:50,440 [salt.minion      ][INFO    ][30579] Starting a new job with PID 30579
2017-09-15 02:13:50,446 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-lldp'] in directory '/root'
2017-09-15 02:13:50,460 [salt.minion      ][INFO    ][30579] Returning information for job: 20170915021350395831
2017-09-15 02:13:50,487 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-nagios'] in directory '/root'
2017-09-15 02:13:50,528 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-swift'] in directory '/root'
2017-09-15 02:13:50,580 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-zookeeper'] in directory '/root'
2017-09-15 02:13:50,616 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-galera'] in directory '/root'
2017-09-15 02:13:50,668 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-graphite'] in directory '/root'
2017-09-15 02:13:50,704 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-prometheus'] in directory '/root'
2017-09-15 02:13:50,754 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-rsyslog'] in directory '/root'
2017-09-15 02:13:50,792 [salt.state       ][INFO    ][30296] All 75 packages are up-to-date.
2017-09-15 02:13:50,792 [salt.state       ][INFO    ][30296] Completed state [salt_master_prd_pkg_formulas] at time 02:13:50.792925 duration_in_ms=3705.819
2017-09-15 02:13:50,793 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass] at time 02:13:50.793259
2017-09-15 02:13:50,793 [salt.state       ][INFO    ][30296] Executing state file.directory for /srv/salt/reclass
2017-09-15 02:13:50,794 [salt.state       ][INFO    ][30296] Directory /srv/salt/reclass is in the correct state
2017-09-15 02:13:50,794 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass] at time 02:13:50.794498 duration_in_ms=1.238
2017-09-15 02:13:50,795 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service] at time 02:13:50.795709
2017-09-15 02:13:50,796 [salt.state       ][INFO    ][30296] Executing state file.directory for /srv/salt/reclass/classes/service
2017-09-15 02:13:50,796 [salt.state       ][INFO    ][30296] Directory /srv/salt/reclass/classes/service is in the correct state
2017-09-15 02:13:50,796 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service] at time 02:13:50.796796 duration_in_ms=1.086
2017-09-15 02:13:50,797 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/powerdns] at time 02:13:50.797630
2017-09-15 02:13:50,797 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/powerdns
2017-09-15 02:13:50,799 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/powerdns is present and owned by root:root
2017-09-15 02:13:50,799 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/powerdns] at time 02:13:50.799299 duration_in_ms=1.67
2017-09-15 02:13:50,800 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/galera] at time 02:13:50.799979
2017-09-15 02:13:50,800 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/galera
2017-09-15 02:13:50,801 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/galera is present and owned by root:root
2017-09-15 02:13:50,801 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/galera] at time 02:13:50.801549 duration_in_ms=1.569
2017-09-15 02:13:50,802 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/telegraf] at time 02:13:50.802233
2017-09-15 02:13:50,802 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/telegraf
2017-09-15 02:13:50,803 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/telegraf is present and owned by root:root
2017-09-15 02:13:50,803 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/telegraf] at time 02:13:50.803793 duration_in_ms=1.56
2017-09-15 02:13:50,804 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/supervisor] at time 02:13:50.804467
2017-09-15 02:13:50,804 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/supervisor
2017-09-15 02:13:50,806 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/supervisor is present and owned by root:root
2017-09-15 02:13:50,806 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/supervisor] at time 02:13:50.806275 duration_in_ms=1.808
2017-09-15 02:13:50,806 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/sensu] at time 02:13:50.806959
2017-09-15 02:13:50,807 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/sensu
2017-09-15 02:13:50,808 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/sensu is present and owned by root:root
2017-09-15 02:13:50,808 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/sensu] at time 02:13:50.808518 duration_in_ms=1.559
2017-09-15 02:13:50,809 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/keepalived] at time 02:13:50.809215
2017-09-15 02:13:50,809 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/keepalived
2017-09-15 02:13:50,810 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/keepalived is present and owned by root:root
2017-09-15 02:13:50,810 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/keepalived] at time 02:13:50.810751 duration_in_ms=1.536
2017-09-15 02:13:50,811 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/zookeeper] at time 02:13:50.811438
2017-09-15 02:13:50,811 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/zookeeper
2017-09-15 02:13:50,812 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/zookeeper is present and owned by root:root
2017-09-15 02:13:50,813 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/zookeeper] at time 02:13:50.813016 duration_in_ms=1.578
2017-09-15 02:13:50,813 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/collectd] at time 02:13:50.813685
2017-09-15 02:13:50,813 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/collectd
2017-09-15 02:13:50,814 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/collectd is present and owned by root:root
2017-09-15 02:13:50,815 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/collectd] at time 02:13:50.815229 duration_in_ms=1.544
2017-09-15 02:13:50,815 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/nagios] at time 02:13:50.815918
2017-09-15 02:13:50,816 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/nagios
2017-09-15 02:13:50,817 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/nagios is present and owned by root:root
2017-09-15 02:13:50,817 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/nagios] at time 02:13:50.817485 duration_in_ms=1.568
2017-09-15 02:13:50,818 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/ceph] at time 02:13:50.818162
2017-09-15 02:13:50,818 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/ceph
2017-09-15 02:13:50,819 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/ceph is present and owned by root:root
2017-09-15 02:13:50,819 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/ceph] at time 02:13:50.819696 duration_in_ms=1.533
2017-09-15 02:13:50,820 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/glusterfs] at time 02:13:50.820379
2017-09-15 02:13:50,820 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/glusterfs
2017-09-15 02:13:50,821 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/glusterfs is present and owned by root:root
2017-09-15 02:13:50,822 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/glusterfs] at time 02:13:50.821984 duration_in_ms=1.605
2017-09-15 02:13:50,822 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/xtrabackup] at time 02:13:50.822656
2017-09-15 02:13:50,822 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/xtrabackup
2017-09-15 02:13:50,823 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/xtrabackup is present and owned by root:root
2017-09-15 02:13:50,824 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/xtrabackup] at time 02:13:50.824209 duration_in_ms=1.554
2017-09-15 02:13:50,824 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/sahara] at time 02:13:50.824928
2017-09-15 02:13:50,825 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/sahara
2017-09-15 02:13:50,826 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/sahara is present and owned by root:root
2017-09-15 02:13:50,826 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/sahara] at time 02:13:50.826474 duration_in_ms=1.547
2017-09-15 02:13:50,827 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/backupninja] at time 02:13:50.827154
2017-09-15 02:13:50,827 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/backupninja
2017-09-15 02:13:50,828 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/backupninja is present and owned by root:root
2017-09-15 02:13:50,828 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/backupninja] at time 02:13:50.828709 duration_in_ms=1.555
2017-09-15 02:13:50,829 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/rsyslog] at time 02:13:50.829393
2017-09-15 02:13:50,829 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/rsyslog
2017-09-15 02:13:50,830 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/rsyslog is present and owned by root:root
2017-09-15 02:13:50,830 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/rsyslog] at time 02:13:50.830923 duration_in_ms=1.53
2017-09-15 02:13:50,831 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/mysql] at time 02:13:50.831603
2017-09-15 02:13:50,831 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/mysql
2017-09-15 02:13:50,832 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/mysql is present and owned by root:root
2017-09-15 02:13:50,833 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/mysql] at time 02:13:50.833176 duration_in_ms=1.574
2017-09-15 02:13:50,833 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/helm] at time 02:13:50.833857
2017-09-15 02:13:50,834 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/helm
2017-09-15 02:13:50,835 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/helm is present and owned by root:root
2017-09-15 02:13:50,835 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/helm] at time 02:13:50.835445 duration_in_ms=1.588
2017-09-15 02:13:50,836 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/freeipa] at time 02:13:50.836126
2017-09-15 02:13:50,836 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/freeipa
2017-09-15 02:13:50,837 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/freeipa is present and owned by root:root
2017-09-15 02:13:50,837 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/freeipa] at time 02:13:50.837683 duration_in_ms=1.557
2017-09-15 02:13:50,838 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/glance] at time 02:13:50.838361
2017-09-15 02:13:50,838 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/glance
2017-09-15 02:13:50,839 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/glance is present and owned by root:root
2017-09-15 02:13:50,839 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/glance] at time 02:13:50.839902 duration_in_ms=1.54
2017-09-15 02:13:50,840 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/rundeck] at time 02:13:50.840570
2017-09-15 02:13:50,840 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/rundeck
2017-09-15 02:13:50,841 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/rundeck is present and owned by root:root
2017-09-15 02:13:50,842 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/rundeck] at time 02:13:50.842133 duration_in_ms=1.563
2017-09-15 02:13:50,842 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/aptly] at time 02:13:50.842811
2017-09-15 02:13:50,843 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/aptly
2017-09-15 02:13:50,844 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/aptly is present and owned by root:root
2017-09-15 02:13:50,844 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/aptly] at time 02:13:50.844334 duration_in_ms=1.523
2017-09-15 02:13:50,845 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/cassandra] at time 02:13:50.845039
2017-09-15 02:13:50,845 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/cassandra
2017-09-15 02:13:50,846 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/cassandra is present and owned by root:root
2017-09-15 02:13:50,846 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/cassandra] at time 02:13:50.846566 duration_in_ms=1.526
2017-09-15 02:13:50,847 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/lldp] at time 02:13:50.847243
2017-09-15 02:13:50,847 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/lldp
2017-09-15 02:13:50,848 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/lldp is present and owned by root:root
2017-09-15 02:13:50,848 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/lldp] at time 02:13:50.848801 duration_in_ms=1.558
2017-09-15 02:13:50,849 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/sphinx] at time 02:13:50.849472
2017-09-15 02:13:50,849 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/sphinx
2017-09-15 02:13:50,850 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/sphinx is present and owned by root:root
2017-09-15 02:13:50,851 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/sphinx] at time 02:13:50.851038 duration_in_ms=1.566
2017-09-15 02:13:50,851 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/git] at time 02:13:50.851705
2017-09-15 02:13:50,852 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/git
2017-09-15 02:13:50,853 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/git is present and owned by root:root
2017-09-15 02:13:50,853 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/git] at time 02:13:50.853268 duration_in_ms=1.563
2017-09-15 02:13:50,853 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/java] at time 02:13:50.853951
2017-09-15 02:13:50,854 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/java
2017-09-15 02:13:50,855 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/java is present and owned by root:root
2017-09-15 02:13:50,855 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/java] at time 02:13:50.855473 duration_in_ms=1.522
2017-09-15 02:13:50,856 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/reclass] at time 02:13:50.856154
2017-09-15 02:13:50,856 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/reclass
2017-09-15 02:13:50,857 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/reclass is present and owned by root:root
2017-09-15 02:13:50,857 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/reclass] at time 02:13:50.857703 duration_in_ms=1.549
2017-09-15 02:13:50,858 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/aodh] at time 02:13:50.858384
2017-09-15 02:13:50,858 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/aodh
2017-09-15 02:13:50,859 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/aodh is present and owned by root:root
2017-09-15 02:13:50,859 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/aodh] at time 02:13:50.859950 duration_in_ms=1.566
2017-09-15 02:13:50,860 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/nova] at time 02:13:50.860619
2017-09-15 02:13:50,860 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/nova
2017-09-15 02:13:50,861 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/nova is present and owned by root:root
2017-09-15 02:13:50,862 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/nova] at time 02:13:50.862133 duration_in_ms=1.514
2017-09-15 02:13:50,862 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/grafana] at time 02:13:50.862794
2017-09-15 02:13:50,863 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/grafana
2017-09-15 02:13:50,864 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/grafana is present and owned by root:root
2017-09-15 02:13:50,864 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/grafana] at time 02:13:50.864277 duration_in_ms=1.482
2017-09-15 02:13:50,864 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/murano] at time 02:13:50.864967
2017-09-15 02:13:50,865 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/murano
2017-09-15 02:13:50,866 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/murano is present and owned by root:root
2017-09-15 02:13:50,866 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/murano] at time 02:13:50.866445 duration_in_ms=1.477
2017-09-15 02:13:50,867 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/keystone] at time 02:13:50.867110
2017-09-15 02:13:50,867 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/keystone
2017-09-15 02:13:50,868 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/keystone is present and owned by root:root
2017-09-15 02:13:50,868 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/keystone] at time 02:13:50.868584 duration_in_ms=1.474
2017-09-15 02:13:50,869 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/etcd] at time 02:13:50.869270
2017-09-15 02:13:50,869 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/etcd
2017-09-15 02:13:50,870 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/etcd is present and owned by root:root
2017-09-15 02:13:50,870 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/etcd] at time 02:13:50.870744 duration_in_ms=1.474
2017-09-15 02:13:50,871 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/mongodb] at time 02:13:50.871413
2017-09-15 02:13:50,871 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/mongodb
2017-09-15 02:13:50,872 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/mongodb is present and owned by root:root
2017-09-15 02:13:50,872 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/mongodb] at time 02:13:50.872936 duration_in_ms=1.522
2017-09-15 02:13:50,873 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/jenkins] at time 02:13:50.873593
2017-09-15 02:13:50,873 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/jenkins
2017-09-15 02:13:50,874 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/jenkins is present and owned by root:root
2017-09-15 02:13:50,875 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/jenkins] at time 02:13:50.875146 duration_in_ms=1.554
2017-09-15 02:13:50,875 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/ccp] at time 02:13:50.875820
2017-09-15 02:13:50,876 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/ccp
2017-09-15 02:13:50,877 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/ccp is present and owned by root:root
2017-09-15 02:13:50,877 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/ccp] at time 02:13:50.877347 duration_in_ms=1.526
2017-09-15 02:13:50,878 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/memcached] at time 02:13:50.878047
2017-09-15 02:13:50,878 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/memcached
2017-09-15 02:13:50,879 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/memcached is present and owned by root:root
2017-09-15 02:13:50,879 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/memcached] at time 02:13:50.879537 duration_in_ms=1.49
2017-09-15 02:13:50,880 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/haproxy] at time 02:13:50.880208
2017-09-15 02:13:50,880 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/haproxy
2017-09-15 02:13:50,881 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/haproxy is present and owned by root:root
2017-09-15 02:13:50,881 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/haproxy] at time 02:13:50.881742 duration_in_ms=1.534
2017-09-15 02:13:50,882 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/neutron] at time 02:13:50.882409
2017-09-15 02:13:50,882 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/neutron
2017-09-15 02:13:50,883 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/neutron is present and owned by root:root
2017-09-15 02:13:50,883 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/neutron] at time 02:13:50.883890 duration_in_ms=1.482
2017-09-15 02:13:50,884 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/designate] at time 02:13:50.884544
2017-09-15 02:13:50,884 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/designate
2017-09-15 02:13:50,885 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/designate is present and owned by root:root
2017-09-15 02:13:50,886 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/designate] at time 02:13:50.886091 duration_in_ms=1.547
2017-09-15 02:13:50,886 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/iptables] at time 02:13:50.886810
2017-09-15 02:13:50,887 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/iptables
2017-09-15 02:13:50,888 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/iptables is present and owned by root:root
2017-09-15 02:13:50,888 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/iptables] at time 02:13:50.888297 duration_in_ms=1.487
2017-09-15 02:13:50,889 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/statsd] at time 02:13:50.888983
2017-09-15 02:13:50,889 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/statsd
2017-09-15 02:13:50,890 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/statsd is present and owned by root:root
2017-09-15 02:13:50,890 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/statsd] at time 02:13:50.890488 duration_in_ms=1.505
2017-09-15 02:13:50,891 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/kibana] at time 02:13:50.891155
2017-09-15 02:13:50,891 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/kibana
2017-09-15 02:13:50,892 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/kibana is present and owned by root:root
2017-09-15 02:13:50,892 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/kibana] at time 02:13:50.892633 duration_in_ms=1.478
2017-09-15 02:13:50,893 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/kubernetes] at time 02:13:50.893330
2017-09-15 02:13:50,893 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/kubernetes
2017-09-15 02:13:50,894 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/kubernetes is present and owned by root:root
2017-09-15 02:13:50,894 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/kubernetes] at time 02:13:50.894816 duration_in_ms=1.485
2017-09-15 02:13:50,895 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/python] at time 02:13:50.895489
2017-09-15 02:13:50,895 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/python
2017-09-15 02:13:50,896 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/python is present and owned by root:root
2017-09-15 02:13:50,897 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/python] at time 02:13:50.897024 duration_in_ms=1.535
2017-09-15 02:13:50,897 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/ntp] at time 02:13:50.897675
2017-09-15 02:13:50,897 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/ntp
2017-09-15 02:13:50,898 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/ntp is present and owned by root:root
2017-09-15 02:13:50,899 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/ntp] at time 02:13:50.899157 duration_in_ms=1.482
2017-09-15 02:13:50,899 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/devops_portal] at time 02:13:50.899824
2017-09-15 02:13:50,900 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/devops_portal
2017-09-15 02:13:50,901 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/devops_portal is present and owned by root:root
2017-09-15 02:13:50,901 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/devops_portal] at time 02:13:50.901347 duration_in_ms=1.523
2017-09-15 02:13:50,902 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/maas] at time 02:13:50.902030
2017-09-15 02:13:50,902 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/maas
2017-09-15 02:13:50,903 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/maas is present and owned by root:root
2017-09-15 02:13:50,903 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/maas] at time 02:13:50.903520 duration_in_ms=1.49
2017-09-15 02:13:50,904 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/libvirt] at time 02:13:50.904191
2017-09-15 02:13:50,904 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/libvirt
2017-09-15 02:13:50,905 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/libvirt is present and owned by root:root
2017-09-15 02:13:50,905 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/libvirt] at time 02:13:50.905692 duration_in_ms=1.502
2017-09-15 02:13:50,906 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/heka] at time 02:13:50.906355
2017-09-15 02:13:50,906 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/heka
2017-09-15 02:13:50,907 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/heka is present and owned by root:root
2017-09-15 02:13:50,907 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/heka] at time 02:13:50.907868 duration_in_ms=1.513
2017-09-15 02:13:50,908 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/heat] at time 02:13:50.908524
2017-09-15 02:13:50,908 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/heat
2017-09-15 02:13:50,909 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/heat is present and owned by root:root
2017-09-15 02:13:50,910 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/heat] at time 02:13:50.910027 duration_in_ms=1.502
2017-09-15 02:13:50,910 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/openldap] at time 02:13:50.910682
2017-09-15 02:13:50,910 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/openldap
2017-09-15 02:13:50,911 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/openldap is present and owned by root:root
2017-09-15 02:13:50,912 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/openldap] at time 02:13:50.912170 duration_in_ms=1.488
2017-09-15 02:13:50,912 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/influxdb] at time 02:13:50.912870
2017-09-15 02:13:50,913 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/influxdb
2017-09-15 02:13:50,914 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/influxdb is present and owned by root:root
2017-09-15 02:13:50,914 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/influxdb] at time 02:13:50.914349 duration_in_ms=1.478
2017-09-15 02:13:50,915 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/apache] at time 02:13:50.915013
2017-09-15 02:13:50,915 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/apache
2017-09-15 02:13:50,916 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/apache is present and owned by root:root
2017-09-15 02:13:50,916 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/apache] at time 02:13:50.916483 duration_in_ms=1.469
2017-09-15 02:13:50,917 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/postgresql] at time 02:13:50.917177
2017-09-15 02:13:50,917 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/postgresql
2017-09-15 02:13:50,918 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/postgresql is present and owned by root:root
2017-09-15 02:13:50,918 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/postgresql] at time 02:13:50.918648 duration_in_ms=1.471
2017-09-15 02:13:50,919 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/swift] at time 02:13:50.919312
2017-09-15 02:13:50,919 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/swift
2017-09-15 02:13:50,920 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/swift is present and owned by root:root
2017-09-15 02:13:50,920 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/swift] at time 02:13:50.920839 duration_in_ms=1.527
2017-09-15 02:13:50,921 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/billometer] at time 02:13:50.921499
2017-09-15 02:13:50,921 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/billometer
2017-09-15 02:13:50,922 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/billometer is present and owned by root:root
2017-09-15 02:13:50,923 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/billometer] at time 02:13:50.922972 duration_in_ms=1.474
2017-09-15 02:13:50,923 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/linux] at time 02:13:50.923627
2017-09-15 02:13:50,923 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/linux
2017-09-15 02:13:50,924 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/linux is present and owned by root:root
2017-09-15 02:13:50,925 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/linux] at time 02:13:50.925152 duration_in_ms=1.524
2017-09-15 02:13:50,925 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/ceilometer] at time 02:13:50.925822
2017-09-15 02:13:50,926 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/ceilometer
2017-09-15 02:13:50,927 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/ceilometer is present and owned by root:root
2017-09-15 02:13:50,927 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/ceilometer] at time 02:13:50.927306 duration_in_ms=1.484
2017-09-15 02:13:50,928 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/aptcacher] at time 02:13:50.927976
2017-09-15 02:13:50,928 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/aptcacher
2017-09-15 02:13:50,929 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/aptcacher is present and owned by root:root
2017-09-15 02:13:50,929 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/aptcacher] at time 02:13:50.929522 duration_in_ms=1.546
2017-09-15 02:13:50,930 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/nginx] at time 02:13:50.930189
2017-09-15 02:13:50,930 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/nginx
2017-09-15 02:13:50,931 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/nginx is present and owned by root:root
2017-09-15 02:13:50,931 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/nginx] at time 02:13:50.931692 duration_in_ms=1.503
2017-09-15 02:13:50,932 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/bind] at time 02:13:50.932353
2017-09-15 02:13:50,932 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/bind
2017-09-15 02:13:50,933 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/bind is present and owned by root:root
2017-09-15 02:13:50,933 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/bind] at time 02:13:50.933875 duration_in_ms=1.522
2017-09-15 02:13:50,934 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/redis] at time 02:13:50.934533
2017-09-15 02:13:50,934 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/redis
2017-09-15 02:13:50,935 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/redis is present and owned by root:root
2017-09-15 02:13:50,936 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/redis] at time 02:13:50.936064 duration_in_ms=1.531
2017-09-15 02:13:50,936 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/opencontrail] at time 02:13:50.936747
2017-09-15 02:13:50,937 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/opencontrail
2017-09-15 02:13:50,938 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/opencontrail is present and owned by root:root
2017-09-15 02:13:50,938 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/opencontrail] at time 02:13:50.938276 duration_in_ms=1.529
2017-09-15 02:13:50,938 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/gerrit] at time 02:13:50.938939
2017-09-15 02:13:50,939 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/gerrit
2017-09-15 02:13:50,940 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/gerrit is present and owned by root:root
2017-09-15 02:13:50,940 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/gerrit] at time 02:13:50.940417 duration_in_ms=1.478
2017-09-15 02:13:50,941 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/rabbitmq] at time 02:13:50.941110
2017-09-15 02:13:50,941 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/rabbitmq
2017-09-15 02:13:50,942 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/rabbitmq is present and owned by root:root
2017-09-15 02:13:50,942 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/rabbitmq] at time 02:13:50.942596 duration_in_ms=1.487
2017-09-15 02:13:50,943 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/octavia] at time 02:13:50.943284
2017-09-15 02:13:50,943 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/octavia
2017-09-15 02:13:50,944 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/octavia is present and owned by root:root
2017-09-15 02:13:50,944 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/octavia] at time 02:13:50.944807 duration_in_ms=1.522
2017-09-15 02:13:50,945 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/graphite] at time 02:13:50.945462
2017-09-15 02:13:50,945 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/graphite
2017-09-15 02:13:50,946 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/graphite is present and owned by root:root
2017-09-15 02:13:50,946 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/graphite] at time 02:13:50.946942 duration_in_ms=1.48
2017-09-15 02:13:50,947 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/elasticsearch] at time 02:13:50.947595
2017-09-15 02:13:50,947 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/elasticsearch
2017-09-15 02:13:50,948 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/elasticsearch is present and owned by root:root
2017-09-15 02:13:50,949 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/elasticsearch] at time 02:13:50.949119 duration_in_ms=1.524
2017-09-15 02:13:50,949 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/horizon] at time 02:13:50.949773
2017-09-15 02:13:50,950 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/horizon
2017-09-15 02:13:50,951 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/horizon is present and owned by root:root
2017-09-15 02:13:50,951 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/horizon] at time 02:13:50.951259 duration_in_ms=1.485
2017-09-15 02:13:50,951 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/openssh] at time 02:13:50.951958
2017-09-15 02:13:50,952 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/openssh
2017-09-15 02:13:50,953 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/openssh is present and owned by root:root
2017-09-15 02:13:50,953 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/openssh] at time 02:13:50.953479 duration_in_ms=1.52
2017-09-15 02:13:50,954 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/cinder] at time 02:13:50.954140
2017-09-15 02:13:50,954 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/cinder
2017-09-15 02:13:50,955 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/cinder is present and owned by root:root
2017-09-15 02:13:50,955 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/cinder] at time 02:13:50.955885 duration_in_ms=1.745
2017-09-15 02:13:50,956 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/docker] at time 02:13:50.956546
2017-09-15 02:13:50,956 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/docker
2017-09-15 02:13:50,957 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/docker is present and owned by root:root
2017-09-15 02:13:50,958 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/docker] at time 02:13:50.958067 duration_in_ms=1.522
2017-09-15 02:13:50,958 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/salt] at time 02:13:50.958722
2017-09-15 02:13:50,959 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/salt
2017-09-15 02:13:50,960 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/salt is present and owned by root:root
2017-09-15 02:13:50,960 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/salt] at time 02:13:50.960218 duration_in_ms=1.495
2017-09-15 02:13:50,960 [salt.state       ][INFO    ][30296] Running state [/srv/salt/reclass/classes/service/prometheus] at time 02:13:50.960916
2017-09-15 02:13:50,961 [salt.state       ][INFO    ][30296] Executing state file.symlink for /srv/salt/reclass/classes/service/prometheus
2017-09-15 02:13:50,962 [salt.state       ][INFO    ][30296] Symlink /srv/salt/reclass/classes/service/prometheus is present and owned by root:root
2017-09-15 02:13:50,962 [salt.state       ][INFO    ][30296] Completed state [/srv/salt/reclass/classes/service/prometheus] at time 02:13:50.962419 duration_in_ms=1.503
2017-09-15 02:13:50,962 [salt.state       ][INFO    ][30296] Running state [salt-minion] at time 02:13:50.962679
2017-09-15 02:13:50,962 [salt.state       ][INFO    ][30296] Executing state pkg.installed for salt-minion
2017-09-15 02:13:50,966 [salt.state       ][INFO    ][30296] Package salt-minion is already installed
2017-09-15 02:13:50,967 [salt.state       ][INFO    ][30296] Completed state [salt-minion] at time 02:13:50.966977 duration_in_ms=4.298
2017-09-15 02:13:50,967 [salt.state       ][INFO    ][30296] Running state [python-yaml] at time 02:13:50.967240
2017-09-15 02:13:50,967 [salt.state       ][INFO    ][30296] Executing state pkg.installed for python-yaml
2017-09-15 02:13:50,971 [salt.state       ][INFO    ][30296] Package python-yaml is already installed
2017-09-15 02:13:50,971 [salt.state       ][INFO    ][30296] Completed state [python-yaml] at time 02:13:50.971390 duration_in_ms=4.149
2017-09-15 02:13:50,971 [salt.state       ][INFO    ][30296] Running state [python-psutil] at time 02:13:50.971648
2017-09-15 02:13:50,971 [salt.state       ][INFO    ][30296] Executing state pkg.installed for python-psutil
2017-09-15 02:13:50,975 [salt.state       ][INFO    ][30296] Package python-psutil is already installed
2017-09-15 02:13:50,975 [salt.state       ][INFO    ][30296] Completed state [python-psutil] at time 02:13:50.975602 duration_in_ms=3.953
2017-09-15 02:13:50,975 [salt.state       ][INFO    ][30296] Running state [python-m2crypto] at time 02:13:50.975871
2017-09-15 02:13:50,976 [salt.state       ][INFO    ][30296] Executing state pkg.installed for python-m2crypto
2017-09-15 02:13:50,979 [salt.state       ][INFO    ][30296] Package python-m2crypto is already installed
2017-09-15 02:13:50,979 [salt.state       ][INFO    ][30296] Completed state [python-m2crypto] at time 02:13:50.979923 duration_in_ms=4.051
2017-09-15 02:13:50,980 [salt.state       ][INFO    ][30296] Running state [/etc/salt/minion.d/minion.conf] at time 02:13:50.980697
2017-09-15 02:13:50,980 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-15 02:13:51,095 [salt.state       ][INFO    ][30296] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-15 02:13:51,095 [salt.state       ][INFO    ][30296] Completed state [/etc/salt/minion.d/minion.conf] at time 02:13:51.095545 duration_in_ms=114.848
2017-09-15 02:13:51,096 [salt.state       ][INFO    ][30296] Running state [/etc/salt/minion.d/_pki.conf] at time 02:13:51.096243
2017-09-15 02:13:51,096 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/salt/minion.d/_pki.conf
2017-09-15 02:13:51,098 [salt.state       ][INFO    ][30296] File /etc/salt/minion.d/_pki.conf is in the correct state
2017-09-15 02:13:51,098 [salt.state       ][INFO    ][30296] Completed state [/etc/salt/minion.d/_pki.conf] at time 02:13:51.098652 duration_in_ms=2.409
2017-09-15 02:13:51,100 [salt.state       ][INFO    ][30296] Running state [salt-minion] at time 02:13:51.100042
2017-09-15 02:13:51,100 [salt.state       ][INFO    ][30296] Executing state service.running for salt-minion
2017-09-15 02:13:51,100 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-15 02:13:51,114 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-15 02:13:51,126 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-15 02:13:51,137 [salt.state       ][INFO    ][30296] The service salt-minion is already running
2017-09-15 02:13:51,137 [salt.state       ][INFO    ][30296] Completed state [salt-minion] at time 02:13:51.137726 duration_in_ms=37.684
2017-09-15 02:13:51,139 [salt.state       ][INFO    ][30296] Running state [/etc/salt/grains.d] at time 02:13:51.139505
2017-09-15 02:13:51,139 [salt.state       ][INFO    ][30296] Executing state file.directory for /etc/salt/grains.d
2017-09-15 02:13:51,140 [salt.state       ][INFO    ][30296] Directory /etc/salt/grains.d is in the correct state
2017-09-15 02:13:51,140 [salt.state       ][INFO    ][30296] Completed state [/etc/salt/grains.d] at time 02:13:51.140754 duration_in_ms=1.25
2017-09-15 02:13:51,141 [salt.state       ][INFO    ][30296] Running state [/etc/salt/grains] at time 02:13:51.141614
2017-09-15 02:13:51,141 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/salt/grains
2017-09-15 02:13:51,142 [salt.state       ][INFO    ][30296] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-15 02:13:51,142 [salt.state       ][INFO    ][30296] Completed state [/etc/salt/grains] at time 02:13:51.142608 duration_in_ms=0.994
2017-09-15 02:13:51,143 [salt.state       ][INFO    ][30296] Running state [/etc/salt/grains.d/placeholder] at time 02:13:51.143316
2017-09-15 02:13:51,143 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-15 02:13:51,144 [salt.state       ][INFO    ][30296] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-15 02:13:51,144 [salt.state       ][INFO    ][30296] Completed state [/etc/salt/grains.d/placeholder] at time 02:13:51.144305 duration_in_ms=0.989
2017-09-15 02:13:51,145 [salt.state       ][INFO    ][30296] Running state [/etc/salt/grains.d/sphinx] at time 02:13:51.145035
2017-09-15 02:13:51,145 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-15 02:13:51,149 [salt.state       ][INFO    ][30296] File /etc/salt/grains.d/sphinx is in the correct state
2017-09-15 02:13:51,150 [salt.state       ][INFO    ][30296] Completed state [/etc/salt/grains.d/sphinx] at time 02:13:51.149975 duration_in_ms=4.939
2017-09-15 02:13:51,150 [salt.state       ][INFO    ][30296] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:13:51.150850
2017-09-15 02:13:51,151 [salt.state       ][INFO    ][30296] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-15 02:13:51,151 [salt.state       ][INFO    ][30296] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-15 02:13:51,151 [salt.state       ][INFO    ][30296] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:13:51.151742 duration_in_ms=0.892
2017-09-15 02:13:51,152 [salt.state       ][INFO    ][30296] Running state [/etc/salt/grains.d/dns_records] at time 02:13:51.152457
2017-09-15 02:13:51,152 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-15 02:13:51,155 [salt.state       ][INFO    ][30296] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-15 02:13:51,156 [salt.state       ][INFO    ][30296] Completed state [/etc/salt/grains.d/dns_records] at time 02:13:51.156007 duration_in_ms=3.55
2017-09-15 02:13:51,156 [salt.state       ][INFO    ][30296] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 02:13:51.156912
2017-09-15 02:13:51,157 [salt.state       ][INFO    ][30296] 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-15 02:13:51,157 [salt.state       ][INFO    ][30296] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-15 02:13:51,157 [salt.state       ][INFO    ][30296] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 02:13:51.157808 duration_in_ms=0.896
2017-09-15 02:13:51,158 [salt.state       ][INFO    ][30296] Running state [/etc/salt/grains.d/salt] at time 02:13:51.158510
2017-09-15 02:13:51,158 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-15 02:13:51,161 [salt.state       ][INFO    ][30296] File /etc/salt/grains.d/salt is in the correct state
2017-09-15 02:13:51,162 [salt.state       ][INFO    ][30296] Completed state [/etc/salt/grains.d/salt] at time 02:13:51.162060 duration_in_ms=3.55
2017-09-15 02:13:51,162 [salt.state       ][INFO    ][30296] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 02:13:51.162942
2017-09-15 02:13:51,163 [salt.state       ][INFO    ][30296] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-15 02:13:51,163 [salt.state       ][INFO    ][30296] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-15 02:13:51,163 [salt.state       ][INFO    ][30296] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 02:13:51.163862 duration_in_ms=0.921
2017-09-15 02:13:51,166 [salt.state       ][INFO    ][30296] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:13:51.166306
2017-09-15 02:13:51,166 [salt.state       ][INFO    ][30296] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-15 02:13:51,166 [salt.state       ][INFO    ][30296] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-15 02:13:51,167 [salt.state       ][INFO    ][30296] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:13:51.167229 duration_in_ms=0.923
2017-09-15 02:13:51,168 [salt.state       ][INFO    ][30296] Running state [mine.update] at time 02:13:51.168091
2017-09-15 02:13:51,168 [salt.state       ][INFO    ][30296] Executing state module.wait for mine.update
2017-09-15 02:13:51,168 [salt.state       ][INFO    ][30296] No changes made for mine.update
2017-09-15 02:13:51,169 [salt.state       ][INFO    ][30296] Completed state [mine.update] at time 02:13:51.168990 duration_in_ms=0.899
2017-09-15 02:13:51,169 [salt.state       ][INFO    ][30296] Running state [/etc/pki/ca/salt_master_ca/certs] at time 02:13:51.169284
2017-09-15 02:13:51,169 [salt.state       ][INFO    ][30296] Executing state file.directory for /etc/pki/ca/salt_master_ca/certs
2017-09-15 02:13:51,170 [salt.state       ][INFO    ][30296] Directory /etc/pki/ca/salt_master_ca/certs is in the correct state
2017-09-15 02:13:51,170 [salt.state       ][INFO    ][30296] Completed state [/etc/pki/ca/salt_master_ca/certs] at time 02:13:51.170338 duration_in_ms=1.054
2017-09-15 02:13:51,170 [salt.state       ][INFO    ][30296] Running state [/etc/pki/ca/salt_master_ca] at time 02:13:51.170630
2017-09-15 02:13:51,170 [salt.state       ][INFO    ][30296] Executing state file.directory for /etc/pki/ca/salt_master_ca
2017-09-15 02:13:51,171 [salt.state       ][INFO    ][30296] Directory /etc/pki/ca/salt_master_ca is in the correct state
2017-09-15 02:13:51,171 [salt.state       ][INFO    ][30296] Completed state [/etc/pki/ca/salt_master_ca] at time 02:13:51.171692 duration_in_ms=1.062
2017-09-15 02:13:51,172 [salt.state       ][INFO    ][30296] Running state [/etc/pki/ca/salt_master_ca/ca.key] at time 02:13:51.172920
2017-09-15 02:13:51,173 [salt.state       ][INFO    ][30296] Executing state x509.private_key_managed for /etc/pki/ca/salt_master_ca/ca.key
2017-09-15 02:13:51,186 [salt.state       ][INFO    ][30296] File /etc/pki/ca/salt_master_ca/ca.key is in the correct state
2017-09-15 02:13:51,186 [salt.state       ][INFO    ][30296] Completed state [/etc/pki/ca/salt_master_ca/ca.key] at time 02:13:51.186527 duration_in_ms=13.606
2017-09-15 02:13:51,187 [salt.state       ][INFO    ][30296] Running state [/etc/pki/ca/salt_master_ca/ca.key] at time 02:13:51.187482
2017-09-15 02:13:51,187 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/pki/ca/salt_master_ca/ca.key
2017-09-15 02:13:51,188 [salt.state       ][INFO    ][30296] File /etc/pki/ca/salt_master_ca/ca.key exists with proper permissions. No changes made.
2017-09-15 02:13:51,188 [salt.state       ][INFO    ][30296] Completed state [/etc/pki/ca/salt_master_ca/ca.key] at time 02:13:51.188726 duration_in_ms=1.244
2017-09-15 02:13:51,189 [salt.state       ][INFO    ][30296] Running state [/etc/pki/ca/salt_master_ca/ca.crt] at time 02:13:51.189464
2017-09-15 02:13:51,189 [salt.state       ][INFO    ][30296] Executing state x509.certificate_managed for /etc/pki/ca/salt_master_ca/ca.crt
2017-09-15 02:13:51,197 [salt.state       ][INFO    ][30296] File /etc/pki/ca/salt_master_ca/ca.crt is in the correct state
2017-09-15 02:13:51,197 [salt.state       ][INFO    ][30296] Completed state [/etc/pki/ca/salt_master_ca/ca.crt] at time 02:13:51.197937 duration_in_ms=8.473
2017-09-15 02:13:51,198 [salt.state       ][INFO    ][30296] Running state [/etc/pki/ca/salt_master_ca/ca.crt] at time 02:13:51.198828
2017-09-15 02:13:51,199 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/pki/ca/salt_master_ca/ca.crt
2017-09-15 02:13:51,199 [salt.loaded.int.states.file][WARNING ][30296] State for file: /etc/pki/ca/salt_master_ca/ca.crt - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2017-09-15 02:13:51,200 [salt.state       ][INFO    ][30296] File /etc/pki/ca/salt_master_ca/ca.crt exists with proper permissions. No changes made.
2017-09-15 02:13:51,200 [salt.state       ][INFO    ][30296] Completed state [/etc/pki/ca/salt_master_ca/ca.crt] at time 02:13:51.200276 duration_in_ms=1.448
2017-09-15 02:13:51,201 [salt.state       ][INFO    ][30296] Running state [mine.send] at time 02:13:51.201010
2017-09-15 02:13:51,201 [salt.state       ][INFO    ][30296] Executing state module.run for mine.send
2017-09-15 02:13:51,704 [salt.state       ][INFO    ][30296] {'ret': True}
2017-09-15 02:13:51,710 [salt.state       ][INFO    ][30296] Completed state [mine.send] at time 02:13:51.710392 duration_in_ms=509.38
2017-09-15 02:13:51,711 [salt.state       ][INFO    ][30296] Running state [ca-certificates] at time 02:13:51.711299
2017-09-15 02:13:51,712 [salt.state       ][INFO    ][30296] Executing state pkg.installed for ca-certificates
2017-09-15 02:13:51,723 [salt.state       ][INFO    ][30296] Package ca-certificates is already installed
2017-09-15 02:13:51,724 [salt.state       ][INFO    ][30296] Completed state [ca-certificates] at time 02:13:51.724334 duration_in_ms=13.035
2017-09-15 02:13:51,726 [salt.state       ][INFO    ][30296] Running state [update-ca-certificates] at time 02:13:51.726530
2017-09-15 02:13:51,727 [salt.state       ][INFO    ][30296] Executing state cmd.wait for update-ca-certificates
2017-09-15 02:13:51,728 [salt.state       ][INFO    ][30296] No changes made for update-ca-certificates
2017-09-15 02:13:51,728 [salt.state       ][INFO    ][30296] Completed state [update-ca-certificates] at time 02:13:51.728627 duration_in_ms=2.096
2017-09-15 02:13:51,729 [salt.state       ][INFO    ][30296] Running state [salt-api] at time 02:13:51.729361
2017-09-15 02:13:51,730 [salt.state       ][INFO    ][30296] Executing state pkg.installed for salt-api
2017-09-15 02:13:51,739 [salt.state       ][INFO    ][30296] Package salt-api is already installed
2017-09-15 02:13:51,739 [salt.state       ][INFO    ][30296] Completed state [salt-api] at time 02:13:51.739873 duration_in_ms=10.512
2017-09-15 02:13:51,741 [salt.state       ][INFO    ][30296] Running state [/etc/salt/master.d/_api.conf] at time 02:13:51.741840
2017-09-15 02:13:51,742 [salt.state       ][INFO    ][30296] Executing state file.managed for /etc/salt/master.d/_api.conf
2017-09-15 02:13:51,897 [salt.state       ][INFO    ][30296] File /etc/salt/master.d/_api.conf is in the correct state
2017-09-15 02:13:51,897 [salt.state       ][INFO    ][30296] Completed state [/etc/salt/master.d/_api.conf] at time 02:13:51.897630 duration_in_ms=155.791
2017-09-15 02:13:51,899 [salt.state       ][INFO    ][30296] Running state [salt-api] at time 02:13:51.899614
2017-09-15 02:13:51,900 [salt.state       ][INFO    ][30296] Executing state service.running for salt-api
2017-09-15 02:13:51,900 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['systemctl', 'status', 'salt-api.service', '-n', '0'] in directory '/root'
2017-09-15 02:13:51,917 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['systemctl', 'is-active', 'salt-api.service'] in directory '/root'
2017-09-15 02:13:51,930 [salt.loaded.int.module.cmdmod][INFO    ][30296] Executing command ['systemctl', 'is-enabled', 'salt-api.service'] in directory '/root'
2017-09-15 02:13:51,943 [salt.state       ][INFO    ][30296] The service salt-api is already running
2017-09-15 02:13:51,944 [salt.state       ][INFO    ][30296] Completed state [salt-api] at time 02:13:51.944080 duration_in_ms=44.465
2017-09-15 02:13:51,950 [salt.minion      ][INFO    ][30296] Returning information for job: 20170915021340309496
2017-09-15 02:13:52,598 [salt.minion      ][INFO    ][30131] User sudo_ubuntu Executing command state.sls with jid 20170915021352581928
2017-09-15 02:13:52,616 [salt.minion      ][INFO    ][30643] Starting a new job with PID 30643
2017-09-15 02:13:53,043 [salt.state       ][INFO    ][30643] Loading fresh modules for state activity
2017-09-15 02:13:53,096 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2017-09-15 02:13:53,128 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2017-09-15 02:13:53,231 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2017-09-15 02:13:53,303 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2017-09-15 02:13:53,364 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2017-09-15 02:13:53,471 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2017-09-15 02:13:53,535 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2017-09-15 02:13:53,585 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2017-09-15 02:13:53,660 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2017-09-15 02:13:53,718 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2017-09-15 02:13:53,774 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2017-09-15 02:13:54,002 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2017-09-15 02:13:54,075 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2017-09-15 02:13:54,139 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2017-09-15 02:13:54,238 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2017-09-15 02:13:54,325 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2017-09-15 02:13:54,445 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2017-09-15 02:13:54,546 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2017-09-15 02:13:54,603 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2017-09-15 02:13:54,655 [salt.state       ][INFO    ][30643] Running state [/etc/environment] at time 02:13:54.655340
2017-09-15 02:13:54,655 [salt.state       ][INFO    ][30643] Executing state file.blockreplace for /etc/environment
2017-09-15 02:13:54,662 [salt.state       ][INFO    ][30643] File changed:
--- 
+++ 
@@ -1 +1,4 @@
 PATH="/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games"
+# SALT MANAGED VARIABLES - DO NOT EDIT - START
+# +# SALT MANAGED VARIABLES - END

2017-09-15 02:13:54,663 [salt.state       ][INFO    ][30643] Completed state [/etc/environment] at time 02:13:54.663155 duration_in_ms=7.816
2017-09-15 02:13:54,663 [salt.state       ][INFO    ][30643] Running state [/etc/profile.d] at time 02:13:54.663462
2017-09-15 02:13:54,663 [salt.state       ][INFO    ][30643] Executing state file.directory for /etc/profile.d
2017-09-15 02:13:54,664 [salt.state       ][INFO    ][30643] Directory /etc/profile.d is in the correct state
2017-09-15 02:13:54,665 [salt.state       ][INFO    ][30643] Completed state [/etc/profile.d] at time 02:13:54.665044 duration_in_ms=1.582
2017-09-15 02:13:55,019 [salt.state       ][INFO    ][30643] Running state [linux_repo_prereq_pkgs] at time 02:13:55.019943
2017-09-15 02:13:55,020 [salt.state       ][INFO    ][30643] Executing state pkg.installed for linux_repo_prereq_pkgs
2017-09-15 02:13:55,021 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 02:13:55,323 [salt.state       ][INFO    ][30643] All specified packages are already installed
2017-09-15 02:13:55,324 [salt.state       ][INFO    ][30643] Completed state [linux_repo_prereq_pkgs] at time 02:13:55.324126 duration_in_ms=304.183
2017-09-15 02:13:55,324 [salt.state       ][INFO    ][30643] Running state [/etc/apt/apt.conf.d/99proxies-salt-salt] at time 02:13:55.324537
2017-09-15 02:13:55,324 [salt.state       ][INFO    ][30643] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-salt
2017-09-15 02:13:55,325 [salt.state       ][INFO    ][30643] File /etc/apt/apt.conf.d/99proxies-salt-salt is not present
2017-09-15 02:13:55,325 [salt.state       ][INFO    ][30643] Completed state [/etc/apt/apt.conf.d/99proxies-salt-salt] at time 02:13:55.325740 duration_in_ms=1.203
2017-09-15 02:13:55,326 [salt.state       ][INFO    ][30643] Running state [/etc/apt/preferences.d/salt] at time 02:13:55.326075
2017-09-15 02:13:55,326 [salt.state       ][INFO    ][30643] Executing state file.absent for /etc/apt/preferences.d/salt
2017-09-15 02:13:55,326 [salt.state       ][INFO    ][30643] File /etc/apt/preferences.d/salt is not present
2017-09-15 02:13:55,327 [salt.state       ][INFO    ][30643] Completed state [/etc/apt/preferences.d/salt] at time 02:13:55.327077 duration_in_ms=1.002
2017-09-15 02:13:55,329 [salt.state       ][INFO    ][30643] Running state [deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial main] at time 02:13:55.329882
2017-09-15 02:13:55,330 [salt.state       ][INFO    ][30643] Executing state pkgrepo.managed for deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial main
2017-09-15 02:13:55,605 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3/SALTSTACK-GPG-KEY.pub'] in directory '/root'
2017-09-15 02:13:55,753 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-15 02:13:59,059 [salt.state       ][INFO    ][30643] {'repo': 'deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial main'}
2017-09-15 02:13:59,060 [salt.state       ][INFO    ][30643] Completed state [deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial main] at time 02:13:59.060754 duration_in_ms=3730.87
2017-09-15 02:13:59,061 [salt.state       ][INFO    ][30643] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 02:13:59.061476
2017-09-15 02:13:59,062 [salt.state       ][INFO    ][30643] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2017-09-15 02:13:59,062 [salt.state       ][INFO    ][30643] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2017-09-15 02:13:59,063 [salt.state       ][INFO    ][30643] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 02:13:59.063412 duration_in_ms=1.935
2017-09-15 02:13:59,064 [salt.state       ][INFO    ][30643] Running state [/etc/apt/preferences.d/uca] at time 02:13:59.063963
2017-09-15 02:13:59,064 [salt.state       ][INFO    ][30643] Executing state file.absent for /etc/apt/preferences.d/uca
2017-09-15 02:13:59,065 [salt.state       ][INFO    ][30643] File /etc/apt/preferences.d/uca is not present
2017-09-15 02:13:59,065 [salt.state       ][INFO    ][30643] Completed state [/etc/apt/preferences.d/uca] at time 02:13:59.065649 duration_in_ms=1.685
2017-09-15 02:13:59,067 [salt.state       ][INFO    ][30643] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 02:13:59.067008
2017-09-15 02:13:59,067 [salt.state       ][INFO    ][30643] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main
2017-09-15 02:13:59,144 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['apt-key', 'export', 'EC4926EA'] in directory '/root'
2017-09-15 02:13:59,203 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['apt-key', 'adv', '--keyserver', 'keyserver.ubuntu.com', '--logger-fd', '1', '--recv-keys', 'EC4926EA'] in directory '/root'
2017-09-15 02:13:59,837 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-15 02:14:02,688 [salt.minion      ][INFO    ][30131] User sudo_ubuntu Executing command saltutil.find_job with jid 20170915021402679784
2017-09-15 02:14:02,714 [salt.minion      ][INFO    ][31707] Starting a new job with PID 31707
2017-09-15 02:14:02,734 [salt.minion      ][INFO    ][31707] Returning information for job: 20170915021402679784
2017-09-15 02:14:04,533 [salt.state       ][INFO    ][30643] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main'}
2017-09-15 02:14:04,534 [salt.state       ][INFO    ][30643] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 02:14:04.534560 duration_in_ms=5467.551
2017-09-15 02:14:04,535 [salt.state       ][INFO    ][30643] Running state [/etc/apt/apt.conf.d/99proxies-salt-mcp_salt] at time 02:14:04.535094
2017-09-15 02:14:04,536 [salt.state       ][INFO    ][30643] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mcp_salt
2017-09-15 02:14:04,537 [salt.state       ][INFO    ][30643] File /etc/apt/apt.conf.d/99proxies-salt-mcp_salt is not present
2017-09-15 02:14:04,537 [salt.state       ][INFO    ][30643] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mcp_salt] at time 02:14:04.537737 duration_in_ms=2.643
2017-09-15 02:14:04,538 [salt.state       ][INFO    ][30643] Running state [/etc/apt/preferences.d/mcp_salt] at time 02:14:04.538180
2017-09-15 02:14:04,538 [salt.state       ][INFO    ][30643] Executing state file.managed for /etc/apt/preferences.d/mcp_salt
2017-09-15 02:14:04,555 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-15 02:14:04,607 [salt.state       ][INFO    ][30643] File changed:
New file
2017-09-15 02:14:04,608 [salt.state       ][INFO    ][30643] Completed state [/etc/apt/preferences.d/mcp_salt] at time 02:14:04.608163 duration_in_ms=69.983
2017-09-15 02:14:04,609 [salt.state       ][INFO    ][30643] Running state [deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly salt] at time 02:14:04.609046
2017-09-15 02:14:04,609 [salt.state       ][INFO    ][30643] Executing state pkgrepo.managed for deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly salt
2017-09-15 02:14:05,034 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt-mk.mirantis.com/public.gpg'] in directory '/root'
2017-09-15 02:14:05,220 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-15 02:14:08,917 [salt.state       ][INFO    ][30643] Made the following changes:
'file' changed from '/etc/apt/sources.list.d/bootstrap.list' to '/etc/apt/sources.list.d/mcp_salt.list'

2017-09-15 02:14:08,917 [salt.state       ][INFO    ][30643] Completed state [deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly salt] at time 02:14:08.917905 duration_in_ms=4308.859
2017-09-15 02:14:08,918 [salt.state       ][INFO    ][30643] Running state [linux_extra_packages_purged] at time 02:14:08.918309
2017-09-15 02:14:08,918 [salt.state       ][INFO    ][30643] Executing state pkg.purged for linux_extra_packages_purged
2017-09-15 02:14:08,939 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', 'purge', 'cloud-init'] in directory '/root'
2017-09-15 02:14:12,604 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 02:14:12,655 [salt.state       ][INFO    ][30643] {'removed': {}, 'installed': {'cloud-init': {'new': '', 'old': '0.7.9-153-g16a7302f-0ubuntu1~16.04.2'}, 'ec2-init': {'new': '', 'old': '1'}}}
2017-09-15 02:14:12,675 [salt.state       ][INFO    ][30643] Loading fresh modules for state activity
2017-09-15 02:14:12,709 [salt.state       ][INFO    ][30643] Completed state [linux_extra_packages_purged] at time 02:14:12.709645 duration_in_ms=3791.333
2017-09-15 02:14:12,717 [salt.state       ][INFO    ][30643] Running state [linux_extra_packages_latest] at time 02:14:12.717148
2017-09-15 02:14:12,718 [salt.state       ][INFO    ][30643] Executing state pkg.latest for linux_extra_packages_latest
2017-09-15 02:14:13,065 [salt.minion      ][INFO    ][30131] User sudo_ubuntu Executing command saltutil.find_job with jid 20170915021412888877
2017-09-15 02:14:13,086 [salt.minion      ][INFO    ][32396] Starting a new job with PID 32396
2017-09-15 02:14:13,097 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['apt-cache', '-q', 'policy', 'mcelog'] in directory '/root'
2017-09-15 02:14:13,101 [salt.minion      ][INFO    ][32396] Returning information for job: 20170915021412888877
2017-09-15 02:14:13,132 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['apt-cache', '-q', 'policy', 'python-msgpack'] in directory '/root'
2017-09-15 02:14:13,206 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2017-09-15 02:14:13,236 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'mcelog'] in directory '/root'
2017-09-15 02:14:18,916 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 02:14:18,968 [salt.state       ][INFO    ][30643] Made the following changes:
'mcelog' changed from 'absent' to '128+dfsg-1'

2017-09-15 02:14:18,985 [salt.state       ][INFO    ][30643] Loading fresh modules for state activity
2017-09-15 02:14:19,017 [salt.state       ][INFO    ][30643] Completed state [linux_extra_packages_latest] at time 02:14:19.017654 duration_in_ms=6300.504
2017-09-15 02:14:19,023 [salt.state       ][INFO    ][30643] Running state [UTC] at time 02:14:19.023600
2017-09-15 02:14:19,024 [salt.state       ][INFO    ][30643] Executing state timezone.system for UTC
2017-09-15 02:14:19,029 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['timedatectl'] in directory '/root'
2017-09-15 02:14:19,125 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['timedatectl'] in directory '/root'
2017-09-15 02:14:19,141 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'timedatectl set-timezone UTC' in directory '/root'
2017-09-15 02:14:19,160 [salt.state       ][INFO    ][30643] {'timezone': 'UTC'}
2017-09-15 02:14:19,160 [salt.state       ][INFO    ][30643] Completed state [UTC] at time 02:14:19.160823 duration_in_ms=137.224
2017-09-15 02:14:19,163 [salt.state       ][INFO    ][30643] Running state [nf_conntrack] at time 02:14:19.163509
2017-09-15 02:14:19,163 [salt.state       ][INFO    ][30643] Executing state kmod.present for nf_conntrack
2017-09-15 02:14:19,164 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'lsmod' in directory '/root'
2017-09-15 02:14:19,251 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'lsmod' in directory '/root'
2017-09-15 02:14:19,270 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'modprobe nf_conntrack' in directory '/root'
2017-09-15 02:14:19,305 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'lsmod' in directory '/root'
2017-09-15 02:14:19,337 [salt.state       ][INFO    ][30643] {'nf_conntrack': 'loaded'}
2017-09-15 02:14:19,337 [salt.state       ][INFO    ][30643] Completed state [nf_conntrack] at time 02:14:19.337570 duration_in_ms=174.06
2017-09-15 02:14:19,340 [salt.state       ][INFO    ][30643] Running state [net.ipv4.tcp_keepalive_probes] at time 02:14:19.340400
2017-09-15 02:14:19,340 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2017-09-15 02:14:19,341 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,394 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2017-09-15 02:14:19,403 [salt.state       ][INFO    ][30643] {'net.ipv4.tcp_keepalive_probes': 8}
2017-09-15 02:14:19,404 [salt.state       ][INFO    ][30643] Completed state [net.ipv4.tcp_keepalive_probes] at time 02:14:19.404184 duration_in_ms=63.784
2017-09-15 02:14:19,404 [salt.state       ][INFO    ][30643] Running state [fs.file-max] at time 02:14:19.404526
2017-09-15 02:14:19,404 [salt.state       ][INFO    ][30643] Executing state sysctl.present for fs.file-max
2017-09-15 02:14:19,405 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,425 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2017-09-15 02:14:19,434 [salt.state       ][INFO    ][30643] {'fs.file-max': 124165}
2017-09-15 02:14:19,434 [salt.state       ][INFO    ][30643] Completed state [fs.file-max] at time 02:14:19.434554 duration_in_ms=30.027
2017-09-15 02:14:19,434 [salt.state       ][INFO    ][30643] Running state [net.core.somaxconn] at time 02:14:19.434863
2017-09-15 02:14:19,435 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.core.somaxconn
2017-09-15 02:14:19,435 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,463 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2017-09-15 02:14:19,475 [salt.state       ][INFO    ][30643] {'net.core.somaxconn': 4096}
2017-09-15 02:14:19,476 [salt.state       ][INFO    ][30643] Completed state [net.core.somaxconn] at time 02:14:19.475958 duration_in_ms=41.093
2017-09-15 02:14:19,476 [salt.state       ][INFO    ][30643] Running state [net.ipv4.tcp_max_syn_backlog] at time 02:14:19.476468
2017-09-15 02:14:19,476 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2017-09-15 02:14:19,477 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,502 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2017-09-15 02:14:19,512 [salt.state       ][INFO    ][30643] {'net.ipv4.tcp_max_syn_backlog': 8192}
2017-09-15 02:14:19,513 [salt.state       ][INFO    ][30643] Completed state [net.ipv4.tcp_max_syn_backlog] at time 02:14:19.513442 duration_in_ms=36.973
2017-09-15 02:14:19,513 [salt.state       ][INFO    ][30643] Running state [net.ipv4.tcp_tw_reuse] at time 02:14:19.513912
2017-09-15 02:14:19,514 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2017-09-15 02:14:19,515 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,532 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2017-09-15 02:14:19,541 [salt.state       ][INFO    ][30643] {'net.ipv4.tcp_tw_reuse': 1}
2017-09-15 02:14:19,541 [salt.state       ][INFO    ][30643] Completed state [net.ipv4.tcp_tw_reuse] at time 02:14:19.541864 duration_in_ms=27.951
2017-09-15 02:14:19,542 [salt.state       ][INFO    ][30643] Running state [net.ipv4.tcp_congestion_control] at time 02:14:19.542298
2017-09-15 02:14:19,542 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2017-09-15 02:14:19,543 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,560 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2017-09-15 02:14:19,574 [salt.state       ][INFO    ][30643] {'net.ipv4.tcp_congestion_control': 'yeah'}
2017-09-15 02:14:19,574 [salt.state       ][INFO    ][30643] Completed state [net.ipv4.tcp_congestion_control] at time 02:14:19.574601 duration_in_ms=32.301
2017-09-15 02:14:19,575 [salt.state       ][INFO    ][30643] Running state [net.nf_conntrack_max] at time 02:14:19.575029
2017-09-15 02:14:19,575 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.nf_conntrack_max
2017-09-15 02:14:19,576 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,593 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2017-09-15 02:14:19,602 [salt.state       ][INFO    ][30643] {'net.nf_conntrack_max': 1048576}
2017-09-15 02:14:19,603 [salt.state       ][INFO    ][30643] Completed state [net.nf_conntrack_max] at time 02:14:19.603414 duration_in_ms=28.385
2017-09-15 02:14:19,603 [salt.state       ][INFO    ][30643] Running state [net.ipv4.tcp_retries2] at time 02:14:19.603834
2017-09-15 02:14:19,604 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.ipv4.tcp_retries2
2017-09-15 02:14:19,604 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,622 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2017-09-15 02:14:19,631 [salt.state       ][INFO    ][30643] {'net.ipv4.tcp_retries2': 5}
2017-09-15 02:14:19,631 [salt.state       ][INFO    ][30643] Completed state [net.ipv4.tcp_retries2] at time 02:14:19.631722 duration_in_ms=27.887
2017-09-15 02:14:19,632 [salt.state       ][INFO    ][30643] Running state [net.ipv4.tcp_keepalive_intvl] at time 02:14:19.632141
2017-09-15 02:14:19,632 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2017-09-15 02:14:19,633 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,649 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2017-09-15 02:14:19,660 [salt.state       ][INFO    ][30643] {'net.ipv4.tcp_keepalive_intvl': 3}
2017-09-15 02:14:19,660 [salt.state       ][INFO    ][30643] Completed state [net.ipv4.tcp_keepalive_intvl] at time 02:14:19.660824 duration_in_ms=28.682
2017-09-15 02:14:19,661 [salt.state       ][INFO    ][30643] Running state [net.ipv4.tcp_slow_start_after_idle] at time 02:14:19.661243
2017-09-15 02:14:19,661 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2017-09-15 02:14:19,662 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,678 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2017-09-15 02:14:19,688 [salt.state       ][INFO    ][30643] {'net.ipv4.tcp_slow_start_after_idle': 0}
2017-09-15 02:14:19,688 [salt.state       ][INFO    ][30643] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 02:14:19.688651 duration_in_ms=27.407
2017-09-15 02:14:19,689 [salt.state       ][INFO    ][30643] Running state [vm.swappiness] at time 02:14:19.689086
2017-09-15 02:14:19,689 [salt.state       ][INFO    ][30643] Executing state sysctl.present for vm.swappiness
2017-09-15 02:14:19,690 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,707 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2017-09-15 02:14:19,715 [salt.state       ][INFO    ][30643] {'vm.swappiness': 10}
2017-09-15 02:14:19,716 [salt.state       ][INFO    ][30643] Completed state [vm.swappiness] at time 02:14:19.716388 duration_in_ms=27.3
2017-09-15 02:14:19,716 [salt.state       ][INFO    ][30643] Running state [net.core.netdev_max_backlog] at time 02:14:19.716853
2017-09-15 02:14:19,717 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.core.netdev_max_backlog
2017-09-15 02:14:19,717 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,735 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2017-09-15 02:14:19,744 [salt.state       ][INFO    ][30643] {'net.core.netdev_max_backlog': 261144}
2017-09-15 02:14:19,745 [salt.state       ][INFO    ][30643] Completed state [net.core.netdev_max_backlog] at time 02:14:19.745270 duration_in_ms=28.416
2017-09-15 02:14:19,745 [salt.state       ][INFO    ][30643] Running state [net.ipv4.neigh.default.gc_thresh1] at time 02:14:19.745682
2017-09-15 02:14:19,746 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2017-09-15 02:14:19,746 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,764 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2017-09-15 02:14:19,774 [salt.state       ][INFO    ][30643] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2017-09-15 02:14:19,775 [salt.state       ][INFO    ][30643] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 02:14:19.775509 duration_in_ms=29.826
2017-09-15 02:14:19,775 [salt.state       ][INFO    ][30643] Running state [net.ipv4.neigh.default.gc_thresh2] at time 02:14:19.775925
2017-09-15 02:14:19,776 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2017-09-15 02:14:19,776 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,795 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2017-09-15 02:14:19,805 [salt.state       ][INFO    ][30643] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2017-09-15 02:14:19,806 [salt.state       ][INFO    ][30643] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 02:14:19.806159 duration_in_ms=30.234
2017-09-15 02:14:19,806 [salt.state       ][INFO    ][30643] Running state [net.ipv4.neigh.default.gc_thresh3] at time 02:14:19.806580
2017-09-15 02:14:19,806 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2017-09-15 02:14:19,807 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,826 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2017-09-15 02:14:19,835 [salt.state       ][INFO    ][30643] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2017-09-15 02:14:19,836 [salt.state       ][INFO    ][30643] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 02:14:19.836515 duration_in_ms=29.934
2017-09-15 02:14:19,836 [salt.state       ][INFO    ][30643] Running state [net.ipv4.tcp_fin_timeout] at time 02:14:19.836959
2017-09-15 02:14:19,837 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2017-09-15 02:14:19,838 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,855 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2017-09-15 02:14:19,865 [salt.state       ][INFO    ][30643] {'net.ipv4.tcp_fin_timeout': 30}
2017-09-15 02:14:19,866 [salt.state       ][INFO    ][30643] Completed state [net.ipv4.tcp_fin_timeout] at time 02:14:19.865976 duration_in_ms=29.016
2017-09-15 02:14:19,866 [salt.state       ][INFO    ][30643] Running state [net.ipv4.tcp_keepalive_time] at time 02:14:19.866399
2017-09-15 02:14:19,866 [salt.state       ][INFO    ][30643] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2017-09-15 02:14:19,867 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,886 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2017-09-15 02:14:19,895 [salt.state       ][INFO    ][30643] {'net.ipv4.tcp_keepalive_time': 30}
2017-09-15 02:14:19,896 [salt.state       ][INFO    ][30643] Completed state [net.ipv4.tcp_keepalive_time] at time 02:14:19.896359 duration_in_ms=29.959
2017-09-15 02:14:19,896 [salt.state       ][INFO    ][30643] Running state [kernel.panic] at time 02:14:19.896809
2017-09-15 02:14:19,897 [salt.state       ][INFO    ][30643] Executing state sysctl.present for kernel.panic
2017-09-15 02:14:19,897 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -a' in directory '/root'
2017-09-15 02:14:19,915 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2017-09-15 02:14:19,925 [salt.state       ][INFO    ][30643] {'kernel.panic': 60}
2017-09-15 02:14:19,925 [salt.state       ][INFO    ][30643] Completed state [kernel.panic] at time 02:14:19.925693 duration_in_ms=28.883
2017-09-15 02:14:19,928 [salt.state       ][INFO    ][30643] Running state [linux_sysfs_package] at time 02:14:19.928663
2017-09-15 02:14:19,929 [salt.state       ][INFO    ][30643] Executing state pkg.installed for linux_sysfs_package
2017-09-15 02:14:20,264 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2017-09-15 02:14:20,307 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-15 02:14:22,075 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2017-09-15 02:14:22,099 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'sysfsutils'] in directory '/root'
2017-09-15 02:14:23,063 [salt.minion      ][INFO    ][30131] User sudo_ubuntu Executing command saltutil.find_job with jid 20170915021423047169
2017-09-15 02:14:23,098 [salt.minion      ][INFO    ][894] Starting a new job with PID 894
2017-09-15 02:14:23,117 [salt.minion      ][INFO    ][894] Returning information for job: 20170915021423047169
2017-09-15 02:14:28,112 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 02:14:28,143 [salt.state       ][INFO    ][30643] Made the following changes:
'libsysfs2' changed from 'absent' to '2.1.0+repack-4'
'sysfsutils' changed from 'absent' to '2.1.0+repack-4'

2017-09-15 02:14:28,152 [salt.state       ][INFO    ][30643] Loading fresh modules for state activity
2017-09-15 02:14:28,173 [salt.state       ][INFO    ][30643] Completed state [linux_sysfs_package] at time 02:14:28.173301 duration_in_ms=8244.634
2017-09-15 02:14:28,178 [salt.state       ][INFO    ][30643] Running state [/etc/sysfs.d] at time 02:14:28.178893
2017-09-15 02:14:28,179 [salt.state       ][INFO    ][30643] Executing state file.directory for /etc/sysfs.d
2017-09-15 02:14:28,184 [salt.state       ][INFO    ][30643] Directory /etc/sysfs.d is in the correct state
2017-09-15 02:14:28,184 [salt.state       ][INFO    ][30643] Completed state [/etc/sysfs.d] at time 02:14:28.184871 duration_in_ms=5.979
2017-09-15 02:14:28,339 [salt.state       ][INFO    ][30643] Running state [ondemand] at time 02:14:28.339666
2017-09-15 02:14:28,340 [salt.state       ][INFO    ][30643] Executing state service.dead for ondemand
2017-09-15 02:14:28,343 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2017-09-15 02:14:28,358 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2017-09-15 02:14:28,372 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-09-15 02:14:28,386 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2017-09-15 02:14:28,437 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2017-09-15 02:14:28,451 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-09-15 02:14:28,462 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-09-15 02:14:28,476 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2017-09-15 02:14:28,568 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-09-15 02:14:28,584 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'runlevel' in directory '/root'
2017-09-15 02:14:28,593 [salt.state       ][INFO    ][30643] {'ondemand': True}
2017-09-15 02:14:28,594 [salt.state       ][INFO    ][30643] Completed state [ondemand] at time 02:14:28.594117 duration_in_ms=254.452
2017-09-15 02:14:28,594 [salt.state       ][INFO    ][30643] Running state [cs_CZ.UTF-8] at time 02:14:28.594905
2017-09-15 02:14:28,595 [salt.state       ][INFO    ][30643] Executing state locale.present for cs_CZ.UTF-8
2017-09-15 02:14:28,595 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'locale -a' in directory '/root'
2017-09-15 02:14:28,607 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2017-09-15 02:14:29,351 [salt.state       ][INFO    ][30643] {'locale': 'cs_CZ.UTF-8'}
2017-09-15 02:14:29,352 [salt.state       ][INFO    ][30643] Completed state [cs_CZ.UTF-8] at time 02:14:29.352197 duration_in_ms=757.283
2017-09-15 02:14:29,352 [salt.state       ][INFO    ][30643] Running state [en_US.UTF-8] at time 02:14:29.352635
2017-09-15 02:14:29,353 [salt.state       ][INFO    ][30643] Executing state locale.present for en_US.UTF-8
2017-09-15 02:14:29,353 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'locale -a' in directory '/root'
2017-09-15 02:14:29,364 [salt.state       ][INFO    ][30643] Locale en_US.UTF-8 is already present
2017-09-15 02:14:29,365 [salt.state       ][INFO    ][30643] Completed state [en_US.UTF-8] at time 02:14:29.365415 duration_in_ms=12.78
2017-09-15 02:14:29,366 [salt.state       ][INFO    ][30643] Running state [en_US.UTF-8] at time 02:14:29.366571
2017-09-15 02:14:29,366 [salt.state       ][INFO    ][30643] Executing state locale.system for en_US.UTF-8
2017-09-15 02:14:29,367 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command 'localectl' in directory '/root'
2017-09-15 02:14:29,465 [salt.state       ][INFO    ][30643] System locale en_US.UTF-8 already set
2017-09-15 02:14:29,466 [salt.state       ][INFO    ][30643] Completed state [en_US.UTF-8] at time 02:14:29.466123 duration_in_ms=99.55
2017-09-15 02:14:29,469 [salt.state       ][INFO    ][30643] Running state [salt] at time 02:14:29.469386
2017-09-15 02:14:29,469 [salt.state       ][INFO    ][30643] Executing state user.present for salt
2017-09-15 02:14:29,471 [salt.state       ][INFO    ][30643] User salt is present and up to date
2017-09-15 02:14:29,471 [salt.state       ][INFO    ][30643] Completed state [salt] at time 02:14:29.471861 duration_in_ms=2.475
2017-09-15 02:14:29,473 [salt.state       ][INFO    ][30643] Running state [/var/tmp/salt] at time 02:14:29.473150
2017-09-15 02:14:29,473 [salt.state       ][INFO    ][30643] Executing state file.directory for /var/tmp/salt
2017-09-15 02:14:29,474 [salt.state       ][INFO    ][30643] Directory /var/tmp/salt is in the correct state
2017-09-15 02:14:29,474 [salt.state       ][INFO    ][30643] Completed state [/var/tmp/salt] at time 02:14:29.474924 duration_in_ms=1.774
2017-09-15 02:14:29,475 [salt.state       ][INFO    ][30643] Running state [/etc/sudoers.d/90-salt-user-salt] at time 02:14:29.475384
2017-09-15 02:14:29,475 [salt.state       ][INFO    ][30643] Executing state file.absent for /etc/sudoers.d/90-salt-user-salt
2017-09-15 02:14:29,476 [salt.state       ][INFO    ][30643] File /etc/sudoers.d/90-salt-user-salt is not present
2017-09-15 02:14:29,476 [salt.state       ][INFO    ][30643] Completed state [/etc/sudoers.d/90-salt-user-salt] at time 02:14:29.476745 duration_in_ms=1.361
2017-09-15 02:14:29,477 [salt.state       ][INFO    ][30643] Running state [root] at time 02:14:29.477181
2017-09-15 02:14:29,477 [salt.state       ][INFO    ][30643] Executing state user.present for root
2017-09-15 02:14:29,478 [salt.state       ][INFO    ][30643] User root is present and up to date
2017-09-15 02:14:29,479 [salt.state       ][INFO    ][30643] Completed state [root] at time 02:14:29.479006 duration_in_ms=1.825
2017-09-15 02:14:29,480 [salt.state       ][INFO    ][30643] Running state [/root] at time 02:14:29.480047
2017-09-15 02:14:29,480 [salt.state       ][INFO    ][30643] Executing state file.directory for /root
2017-09-15 02:14:29,481 [salt.state       ][INFO    ][30643] Directory /root is in the correct state
2017-09-15 02:14:29,481 [salt.state       ][INFO    ][30643] Completed state [/root] at time 02:14:29.481624 duration_in_ms=1.577
2017-09-15 02:14:29,482 [salt.state       ][INFO    ][30643] Running state [/etc/sudoers.d/90-salt-user-root] at time 02:14:29.482039
2017-09-15 02:14:29,482 [salt.state       ][INFO    ][30643] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2017-09-15 02:14:29,482 [salt.state       ][INFO    ][30643] File /etc/sudoers.d/90-salt-user-root is not present
2017-09-15 02:14:29,483 [salt.state       ][INFO    ][30643] Completed state [/etc/sudoers.d/90-salt-user-root] at time 02:14:29.483320 duration_in_ms=1.281
2017-09-15 02:14:29,483 [salt.state       ][INFO    ][30643] Running state [ubuntu] at time 02:14:29.483765
2017-09-15 02:14:29,484 [salt.state       ][INFO    ][30643] Executing state user.present for ubuntu
2017-09-15 02:14:29,485 [salt.state       ][INFO    ][30643] User ubuntu is present and up to date
2017-09-15 02:14:29,485 [salt.state       ][INFO    ][30643] Completed state [ubuntu] at time 02:14:29.485646 duration_in_ms=1.881
2017-09-15 02:14:29,486 [salt.state       ][INFO    ][30643] Running state [/home/ubuntu] at time 02:14:29.486645
2017-09-15 02:14:29,487 [salt.state       ][INFO    ][30643] Executing state file.directory for /home/ubuntu
2017-09-15 02:14:29,487 [salt.state       ][INFO    ][30643] Directory /home/ubuntu is in the correct state
2017-09-15 02:14:29,488 [salt.state       ][INFO    ][30643] Completed state [/home/ubuntu] at time 02:14:29.488154 duration_in_ms=1.508
2017-09-15 02:14:29,489 [salt.state       ][INFO    ][30643] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 02:14:29.489049
2017-09-15 02:14:29,489 [salt.state       ][INFO    ][30643] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2017-09-15 02:14:29,509 [salt.state       ][INFO    ][30643] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2017-09-15 02:14:29,509 [salt.state       ][INFO    ][30643] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 02:14:29.509875 duration_in_ms=20.826
2017-09-15 02:14:29,510 [salt.state       ][INFO    ][30643] Running state [/etc/security/limits.d/90-salt-default.conf] at time 02:14:29.510294
2017-09-15 02:14:29,510 [salt.state       ][INFO    ][30643] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2017-09-15 02:14:29,524 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2017-09-15 02:14:29,578 [salt.state       ][INFO    ][30643] File changed:
New file
2017-09-15 02:14:29,579 [salt.state       ][INFO    ][30643] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 02:14:29.579397 duration_in_ms=69.102
2017-09-15 02:14:29,579 [salt.state       ][INFO    ][30643] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 02:14:29.579754
2017-09-15 02:14:29,580 [salt.state       ][INFO    ][30643] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2017-09-15 02:14:29,592 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2017-09-15 02:14:29,636 [salt.state       ][INFO    ][30643] File changed:
New file
2017-09-15 02:14:29,636 [salt.state       ][INFO    ][30643] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 02:14:29.636952 duration_in_ms=57.197
2017-09-15 02:14:29,638 [salt.state       ][INFO    ][30643] Running state [service.systemctl_reload] at time 02:14:29.638101
2017-09-15 02:14:29,638 [salt.state       ][INFO    ][30643] Executing state module.wait for service.systemctl_reload
2017-09-15 02:14:29,638 [salt.state       ][INFO    ][30643] No changes made for service.systemctl_reload
2017-09-15 02:14:29,639 [salt.state       ][INFO    ][30643] Completed state [service.systemctl_reload] at time 02:14:29.639038 duration_in_ms=0.938
2017-09-15 02:14:29,639 [salt.state       ][INFO    ][30643] Running state [service.systemctl_reload] at time 02:14:29.639325
2017-09-15 02:14:29,639 [salt.state       ][INFO    ][30643] Executing state module.mod_watch for service.systemctl_reload
2017-09-15 02:14:29,640 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-15 02:14:29,719 [salt.state       ][INFO    ][30643] {'ret': True}
2017-09-15 02:14:29,719 [salt.state       ][INFO    ][30643] Completed state [service.systemctl_reload] at time 02:14:29.719768 duration_in_ms=80.442
2017-09-15 02:14:29,720 [salt.state       ][INFO    ][30643] Running state [/etc/hostname] at time 02:14:29.720083
2017-09-15 02:14:29,720 [salt.state       ][INFO    ][30643] Executing state file.managed for /etc/hostname
2017-09-15 02:14:29,735 [salt.fileclient  ][INFO    ][30643] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2017-09-15 02:14:29,738 [salt.state       ][INFO    ][30643] File /etc/hostname is in the correct state
2017-09-15 02:14:29,738 [salt.state       ][INFO    ][30643] Completed state [/etc/hostname] at time 02:14:29.738882 duration_in_ms=18.798
2017-09-15 02:14:29,741 [salt.state       ][INFO    ][30643] Running state [hostname cfg01] at time 02:14:29.741339
2017-09-15 02:14:29,741 [salt.state       ][INFO    ][30643] Executing state cmd.wait for hostname cfg01
2017-09-15 02:14:29,741 [salt.state       ][INFO    ][30643] No changes made for hostname cfg01
2017-09-15 02:14:29,742 [salt.state       ][INFO    ][30643] Completed state [hostname cfg01] at time 02:14:29.742162 duration_in_ms=0.822
2017-09-15 02:14:29,742 [salt.state       ][INFO    ][30643] Running state [mdb02.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.742766
2017-09-15 02:14:29,743 [salt.state       ][INFO    ][30643] Executing state host.present for mdb02.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,745 [salt.state       ][INFO    ][30643] {'host': 'mdb02.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,745 [salt.state       ][INFO    ][30643] Completed state [mdb02.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.745641 duration_in_ms=2.875
2017-09-15 02:14:29,745 [salt.state       ][INFO    ][30643] Running state [mdb02] at time 02:14:29.745882
2017-09-15 02:14:29,746 [salt.state       ][INFO    ][30643] Executing state host.present for mdb02
2017-09-15 02:14:29,755 [salt.state       ][INFO    ][30643] {'host': 'mdb02'}
2017-09-15 02:14:29,755 [salt.state       ][INFO    ][30643] Completed state [mdb02] at time 02:14:29.755771 duration_in_ms=9.889
2017-09-15 02:14:29,756 [salt.state       ][INFO    ][30643] Running state [mdb03.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.756033
2017-09-15 02:14:29,756 [salt.state       ][INFO    ][30643] Executing state host.present for mdb03.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,761 [salt.state       ][INFO    ][30643] {'host': 'mdb03.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,761 [salt.state       ][INFO    ][30643] Completed state [mdb03.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.761393 duration_in_ms=5.36
2017-09-15 02:14:29,761 [salt.state       ][INFO    ][30643] Running state [mdb03] at time 02:14:29.761674
2017-09-15 02:14:29,761 [salt.state       ][INFO    ][30643] Executing state host.present for mdb03
2017-09-15 02:14:29,767 [salt.state       ][INFO    ][30643] {'host': 'mdb03'}
2017-09-15 02:14:29,767 [salt.state       ][INFO    ][30643] Completed state [mdb03] at time 02:14:29.767516 duration_in_ms=5.842
2017-09-15 02:14:29,767 [salt.state       ][INFO    ][30643] Running state [mdb01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.767791
2017-09-15 02:14:29,768 [salt.state       ][INFO    ][30643] Executing state host.present for mdb01.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,773 [salt.state       ][INFO    ][30643] {'host': 'mdb01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,773 [salt.state       ][INFO    ][30643] Completed state [mdb01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.773425 duration_in_ms=5.634
2017-09-15 02:14:29,773 [salt.state       ][INFO    ][30643] Running state [mdb01] at time 02:14:29.773684
2017-09-15 02:14:29,773 [salt.state       ][INFO    ][30643] Executing state host.present for mdb01
2017-09-15 02:14:29,779 [salt.state       ][INFO    ][30643] {'host': 'mdb01'}
2017-09-15 02:14:29,779 [salt.state       ][INFO    ][30643] Completed state [mdb01] at time 02:14:29.779531 duration_in_ms=5.847
2017-09-15 02:14:29,779 [salt.state       ][INFO    ][30643] Running state [mdb] at time 02:14:29.779795
2017-09-15 02:14:29,780 [salt.state       ][INFO    ][30643] Executing state host.present for mdb
2017-09-15 02:14:29,785 [salt.state       ][INFO    ][30643] {'host': 'mdb'}
2017-09-15 02:14:29,785 [salt.state       ][INFO    ][30643] Completed state [mdb] at time 02:14:29.785448 duration_in_ms=5.653
2017-09-15 02:14:29,785 [salt.state       ][INFO    ][30643] Running state [mdb.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.785715
2017-09-15 02:14:29,786 [salt.state       ][INFO    ][30643] Executing state host.present for mdb.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,791 [salt.state       ][INFO    ][30643] {'host': 'mdb.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,791 [salt.state       ][INFO    ][30643] Completed state [mdb.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.791644 duration_in_ms=5.929
2017-09-15 02:14:29,791 [salt.state       ][INFO    ][30643] Running state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.791914
2017-09-15 02:14:29,792 [salt.state       ][INFO    ][30643] Executing state host.present for cfg01.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,797 [salt.state       ][INFO    ][30643] {'host': 'cfg01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,797 [salt.state       ][INFO    ][30643] Completed state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.797457 duration_in_ms=5.542
2017-09-15 02:14:29,797 [salt.state       ][INFO    ][30643] Running state [cfg01] at time 02:14:29.797743
2017-09-15 02:14:29,798 [salt.state       ][INFO    ][30643] Executing state host.present for cfg01
2017-09-15 02:14:29,803 [salt.state       ][INFO    ][30643] {'host': 'cfg01'}
2017-09-15 02:14:29,803 [salt.state       ][INFO    ][30643] Completed state [cfg01] at time 02:14:29.803635 duration_in_ms=5.892
2017-09-15 02:14:29,803 [salt.state       ][INFO    ][30643] Running state [prx01] at time 02:14:29.803917
2017-09-15 02:14:29,804 [salt.state       ][INFO    ][30643] Executing state host.present for prx01
2017-09-15 02:14:29,809 [salt.state       ][INFO    ][30643] {'host': 'prx01'}
2017-09-15 02:14:29,809 [salt.state       ][INFO    ][30643] Completed state [prx01] at time 02:14:29.809547 duration_in_ms=5.63
2017-09-15 02:14:29,809 [salt.state       ][INFO    ][30643] Running state [prx01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.809857
2017-09-15 02:14:29,810 [salt.state       ][INFO    ][30643] Executing state host.present for prx01.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,815 [salt.state       ][INFO    ][30643] {'host': 'prx01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,815 [salt.state       ][INFO    ][30643] Completed state [prx01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.815608 duration_in_ms=5.751
2017-09-15 02:14:29,815 [salt.state       ][INFO    ][30643] Running state [kvm01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.815915
2017-09-15 02:14:29,816 [salt.state       ][INFO    ][30643] Executing state host.present for kvm01.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,821 [salt.state       ][INFO    ][30643] {'host': 'kvm01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,821 [salt.state       ][INFO    ][30643] Completed state [kvm01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.821614 duration_in_ms=5.698
2017-09-15 02:14:29,821 [salt.state       ][INFO    ][30643] Running state [kvm01] at time 02:14:29.821909
2017-09-15 02:14:29,822 [salt.state       ][INFO    ][30643] Executing state host.present for kvm01
2017-09-15 02:14:29,827 [salt.state       ][INFO    ][30643] {'host': 'kvm01'}
2017-09-15 02:14:29,827 [salt.state       ][INFO    ][30643] Completed state [kvm01] at time 02:14:29.827615 duration_in_ms=5.707
2017-09-15 02:14:29,827 [salt.state       ][INFO    ][30643] Running state [kvm03.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.827911
2017-09-15 02:14:29,828 [salt.state       ][INFO    ][30643] Executing state host.present for kvm03.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,829 [salt.state       ][INFO    ][30643] {'host': 'kvm03.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,830 [salt.state       ][INFO    ][30643] Completed state [kvm03.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.829986 duration_in_ms=2.075
2017-09-15 02:14:29,830 [salt.state       ][INFO    ][30643] Running state [kvm03] at time 02:14:29.830303
2017-09-15 02:14:29,830 [salt.state       ][INFO    ][30643] Executing state host.present for kvm03
2017-09-15 02:14:29,835 [salt.state       ][INFO    ][30643] {'host': 'kvm03'}
2017-09-15 02:14:29,836 [salt.state       ][INFO    ][30643] Completed state [kvm03] at time 02:14:29.836069 duration_in_ms=5.765
2017-09-15 02:14:29,836 [salt.state       ][INFO    ][30643] Running state [kvm02.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.836394
2017-09-15 02:14:29,836 [salt.state       ][INFO    ][30643] Executing state host.present for kvm02.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,841 [salt.state       ][INFO    ][30643] {'host': 'kvm02.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,842 [salt.state       ][INFO    ][30643] Completed state [kvm02.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.842047 duration_in_ms=5.654
2017-09-15 02:14:29,842 [salt.state       ][INFO    ][30643] Running state [kvm02] at time 02:14:29.842378
2017-09-15 02:14:29,842 [salt.state       ][INFO    ][30643] Executing state host.present for kvm02
2017-09-15 02:14:29,854 [salt.state       ][INFO    ][30643] {'host': 'kvm02'}
2017-09-15 02:14:29,854 [salt.state       ][INFO    ][30643] Completed state [kvm02] at time 02:14:29.854261 duration_in_ms=11.884
2017-09-15 02:14:29,854 [salt.state       ][INFO    ][30643] Running state [dbs] at time 02:14:29.854593
2017-09-15 02:14:29,854 [salt.state       ][INFO    ][30643] Executing state host.present for dbs
2017-09-15 02:14:29,859 [salt.state       ][INFO    ][30643] {'host': 'dbs'}
2017-09-15 02:14:29,860 [salt.state       ][INFO    ][30643] Completed state [dbs] at time 02:14:29.860076 duration_in_ms=5.483
2017-09-15 02:14:29,860 [salt.state       ][INFO    ][30643] Running state [dbs.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.860416
2017-09-15 02:14:29,860 [salt.state       ][INFO    ][30643] Executing state host.present for dbs.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,865 [salt.state       ][INFO    ][30643] {'host': 'dbs.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,866 [salt.state       ][INFO    ][30643] Completed state [dbs.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.866064 duration_in_ms=5.649
2017-09-15 02:14:29,866 [salt.state       ][INFO    ][30643] Running state [prx.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.866429
2017-09-15 02:14:29,866 [salt.state       ][INFO    ][30643] Executing state host.present for prx.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,871 [salt.state       ][INFO    ][30643] {'host': 'prx.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,872 [salt.state       ][INFO    ][30643] Completed state [prx.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.872038 duration_in_ms=5.609
2017-09-15 02:14:29,872 [salt.state       ][INFO    ][30643] Running state [prx] at time 02:14:29.872402
2017-09-15 02:14:29,872 [salt.state       ][INFO    ][30643] Executing state host.present for prx
2017-09-15 02:14:29,877 [salt.state       ][INFO    ][30643] {'host': 'prx'}
2017-09-15 02:14:29,878 [salt.state       ][INFO    ][30643] Completed state [prx] at time 02:14:29.878057 duration_in_ms=5.655
2017-09-15 02:14:29,878 [salt.state       ][INFO    ][30643] Running state [prx02] at time 02:14:29.878412
2017-09-15 02:14:29,878 [salt.state       ][INFO    ][30643] Executing state host.present for prx02
2017-09-15 02:14:29,883 [salt.state       ][INFO    ][30643] {'host': 'prx02'}
2017-09-15 02:14:29,884 [salt.state       ][INFO    ][30643] Completed state [prx02] at time 02:14:29.884066 duration_in_ms=5.655
2017-09-15 02:14:29,884 [salt.state       ][INFO    ][30643] Running state [prx02.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.884415
2017-09-15 02:14:29,884 [salt.state       ][INFO    ][30643] Executing state host.present for prx02.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,889 [salt.state       ][INFO    ][30643] {'host': 'prx02.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,890 [salt.state       ][INFO    ][30643] Completed state [prx02.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.890090 duration_in_ms=5.674
2017-09-15 02:14:29,890 [salt.state       ][INFO    ][30643] Running state [msg02.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.890443
2017-09-15 02:14:29,890 [salt.state       ][INFO    ][30643] Executing state host.present for msg02.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,895 [salt.state       ][INFO    ][30643] {'host': 'msg02.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,896 [salt.state       ][INFO    ][30643] Completed state [msg02.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.896095 duration_in_ms=5.651
2017-09-15 02:14:29,896 [salt.state       ][INFO    ][30643] Running state [msg02] at time 02:14:29.896451
2017-09-15 02:14:29,896 [salt.state       ][INFO    ][30643] Executing state host.present for msg02
2017-09-15 02:14:29,901 [salt.state       ][INFO    ][30643] {'host': 'msg02'}
2017-09-15 02:14:29,902 [salt.state       ][INFO    ][30643] Completed state [msg02] at time 02:14:29.902043 duration_in_ms=5.591
2017-09-15 02:14:29,902 [salt.state       ][INFO    ][30643] Running state [msg03.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.902400
2017-09-15 02:14:29,902 [salt.state       ][INFO    ][30643] Executing state host.present for msg03.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,907 [salt.state       ][INFO    ][30643] {'host': 'msg03.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,908 [salt.state       ][INFO    ][30643] Completed state [msg03.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.908160 duration_in_ms=5.759
2017-09-15 02:14:29,908 [salt.state       ][INFO    ][30643] Running state [msg03] at time 02:14:29.908513
2017-09-15 02:14:29,908 [salt.state       ][INFO    ][30643] Executing state host.present for msg03
2017-09-15 02:14:29,913 [salt.state       ][INFO    ][30643] {'host': 'msg03'}
2017-09-15 02:14:29,914 [salt.state       ][INFO    ][30643] Completed state [msg03] at time 02:14:29.914101 duration_in_ms=5.588
2017-09-15 02:14:29,914 [salt.state       ][INFO    ][30643] Running state [msg01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.914467
2017-09-15 02:14:29,914 [salt.state       ][INFO    ][30643] Executing state host.present for msg01.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,919 [salt.state       ][INFO    ][30643] {'host': 'msg01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,920 [salt.state       ][INFO    ][30643] Completed state [msg01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.920124 duration_in_ms=5.656
2017-09-15 02:14:29,920 [salt.state       ][INFO    ][30643] Running state [msg01] at time 02:14:29.920489
2017-09-15 02:14:29,920 [salt.state       ][INFO    ][30643] Executing state host.present for msg01
2017-09-15 02:14:29,925 [salt.state       ][INFO    ][30643] {'host': 'msg01'}
2017-09-15 02:14:29,926 [salt.state       ][INFO    ][30643] Completed state [msg01] at time 02:14:29.926161 duration_in_ms=5.672
2017-09-15 02:14:29,926 [salt.state       ][INFO    ][30643] Running state [msg] at time 02:14:29.926522
2017-09-15 02:14:29,926 [salt.state       ][INFO    ][30643] Executing state host.present for msg
2017-09-15 02:14:29,929 [salt.state       ][INFO    ][30643] {'host': 'msg'}
2017-09-15 02:14:29,930 [salt.state       ][INFO    ][30643] Completed state [msg] at time 02:14:29.930301 duration_in_ms=3.779
2017-09-15 02:14:29,930 [salt.state       ][INFO    ][30643] Running state [msg.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.930747
2017-09-15 02:14:29,931 [salt.state       ][INFO    ][30643] Executing state host.present for msg.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,935 [salt.state       ][INFO    ][30643] {'host': 'msg.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,935 [salt.state       ][INFO    ][30643] Completed state [msg.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.935565 duration_in_ms=4.818
2017-09-15 02:14:29,935 [salt.state       ][INFO    ][30643] Running state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.935901
2017-09-15 02:14:29,936 [salt.state       ][INFO    ][30643] Executing state host.present for cfg01.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,936 [salt.state       ][INFO    ][30643] Host cfg01.baremetal-mcp-ocata-odl-ha.local (10.167.4.100) already present
2017-09-15 02:14:29,937 [salt.state       ][INFO    ][30643] Completed state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.937225 duration_in_ms=1.323
2017-09-15 02:14:29,937 [salt.state       ][INFO    ][30643] Running state [cfg01] at time 02:14:29.937552
2017-09-15 02:14:29,937 [salt.state       ][INFO    ][30643] Executing state host.present for cfg01
2017-09-15 02:14:29,938 [salt.state       ][INFO    ][30643] Host cfg01 (10.167.4.100) already present
2017-09-15 02:14:29,938 [salt.state       ][INFO    ][30643] Completed state [cfg01] at time 02:14:29.938753 duration_in_ms=1.201
2017-09-15 02:14:29,939 [salt.state       ][INFO    ][30643] Running state [cmp002] at time 02:14:29.939069
2017-09-15 02:14:29,939 [salt.state       ][INFO    ][30643] Executing state host.present for cmp002
2017-09-15 02:14:29,941 [salt.state       ][INFO    ][30643] {'host': 'cmp002'}
2017-09-15 02:14:29,941 [salt.state       ][INFO    ][30643] Completed state [cmp002] at time 02:14:29.941405 duration_in_ms=2.336
2017-09-15 02:14:29,941 [salt.state       ][INFO    ][30643] Running state [cmp002.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.941721
2017-09-15 02:14:29,942 [salt.state       ][INFO    ][30643] Executing state host.present for cmp002.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,953 [salt.state       ][INFO    ][30643] {'host': 'cmp002.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,953 [salt.state       ][INFO    ][30643] Completed state [cmp002.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.953844 duration_in_ms=12.122
2017-09-15 02:14:29,954 [salt.state       ][INFO    ][30643] Running state [cmp001] at time 02:14:29.954167
2017-09-15 02:14:29,954 [salt.state       ][INFO    ][30643] Executing state host.present for cmp001
2017-09-15 02:14:29,959 [salt.state       ][INFO    ][30643] {'host': 'cmp001'}
2017-09-15 02:14:29,959 [salt.state       ][INFO    ][30643] Completed state [cmp001] at time 02:14:29.959562 duration_in_ms=5.395
2017-09-15 02:14:29,959 [salt.state       ][INFO    ][30643] Running state [cmp001.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.959888
2017-09-15 02:14:29,960 [salt.state       ][INFO    ][30643] Executing state host.present for cmp001.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,965 [salt.state       ][INFO    ][30643] {'host': 'cmp001.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,965 [salt.state       ][INFO    ][30643] Completed state [cmp001.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.965522 duration_in_ms=5.634
2017-09-15 02:14:29,965 [salt.state       ][INFO    ][30643] Running state [dbs01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.965851
2017-09-15 02:14:29,966 [salt.state       ][INFO    ][30643] Executing state host.present for dbs01.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,971 [salt.state       ][INFO    ][30643] {'host': 'dbs01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,971 [salt.state       ][INFO    ][30643] Completed state [dbs01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.971607 duration_in_ms=5.755
2017-09-15 02:14:29,971 [salt.state       ][INFO    ][30643] Running state [dbs01] at time 02:14:29.971936
2017-09-15 02:14:29,972 [salt.state       ][INFO    ][30643] Executing state host.present for dbs01
2017-09-15 02:14:29,977 [salt.state       ][INFO    ][30643] {'host': 'dbs01'}
2017-09-15 02:14:29,977 [salt.state       ][INFO    ][30643] Completed state [dbs01] at time 02:14:29.977577 duration_in_ms=5.642
2017-09-15 02:14:29,977 [salt.state       ][INFO    ][30643] Running state [dbs02.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.977909
2017-09-15 02:14:29,978 [salt.state       ][INFO    ][30643] Executing state host.present for dbs02.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,983 [salt.state       ][INFO    ][30643] {'host': 'dbs02.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,983 [salt.state       ][INFO    ][30643] Completed state [dbs02.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.983636 duration_in_ms=5.727
2017-09-15 02:14:29,984 [salt.state       ][INFO    ][30643] Running state [dbs02] at time 02:14:29.983962
2017-09-15 02:14:29,984 [salt.state       ][INFO    ][30643] Executing state host.present for dbs02
2017-09-15 02:14:29,989 [salt.state       ][INFO    ][30643] {'host': 'dbs02'}
2017-09-15 02:14:29,989 [salt.state       ][INFO    ][30643] Completed state [dbs02] at time 02:14:29.989578 duration_in_ms=5.616
2017-09-15 02:14:29,989 [salt.state       ][INFO    ][30643] Running state [dbs03.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.989932
2017-09-15 02:14:29,990 [salt.state       ][INFO    ][30643] Executing state host.present for dbs03.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:29,995 [salt.state       ][INFO    ][30643] {'host': 'dbs03.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:29,995 [salt.state       ][INFO    ][30643] Completed state [dbs03.baremetal-mcp-ocata-odl-ha.local] at time 02:14:29.995728 duration_in_ms=5.795
2017-09-15 02:14:29,996 [salt.state       ][INFO    ][30643] Running state [dbs03] at time 02:14:29.996051
2017-09-15 02:14:29,996 [salt.state       ][INFO    ][30643] Executing state host.present for dbs03
2017-09-15 02:14:30,001 [salt.state       ][INFO    ][30643] {'host': 'dbs03'}
2017-09-15 02:14:30,001 [salt.state       ][INFO    ][30643] Completed state [dbs03] at time 02:14:30.001609 duration_in_ms=5.557
2017-09-15 02:14:30,001 [salt.state       ][INFO    ][30643] Running state [odl01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:30.001943
2017-09-15 02:14:30,002 [salt.state       ][INFO    ][30643] Executing state host.present for odl01.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:30,007 [salt.state       ][INFO    ][30643] {'host': 'odl01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:30,007 [salt.state       ][INFO    ][30643] Completed state [odl01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:30.007679 duration_in_ms=5.736
2017-09-15 02:14:30,008 [salt.state       ][INFO    ][30643] Running state [odl01] at time 02:14:30.008006
2017-09-15 02:14:30,008 [salt.state       ][INFO    ][30643] Executing state host.present for odl01
2017-09-15 02:14:30,013 [salt.state       ][INFO    ][30643] {'host': 'odl01'}
2017-09-15 02:14:30,013 [salt.state       ][INFO    ][30643] Completed state [odl01] at time 02:14:30.013684 duration_in_ms=5.679
2017-09-15 02:14:30,014 [salt.state       ][INFO    ][30643] Running state [mas01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:30.014011
2017-09-15 02:14:30,014 [salt.state       ][INFO    ][30643] Executing state host.present for mas01.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:30,019 [salt.state       ][INFO    ][30643] {'host': 'mas01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:30,019 [salt.state       ][INFO    ][30643] Completed state [mas01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:30.019793 duration_in_ms=5.782
2017-09-15 02:14:30,020 [salt.state       ][INFO    ][30643] Running state [mas01] at time 02:14:30.020122
2017-09-15 02:14:30,020 [salt.state       ][INFO    ][30643] Executing state host.present for mas01
2017-09-15 02:14:30,025 [salt.state       ][INFO    ][30643] {'host': 'mas01'}
2017-09-15 02:14:30,025 [salt.state       ][INFO    ][30643] Completed state [mas01] at time 02:14:30.025659 duration_in_ms=5.536
2017-09-15 02:14:30,026 [salt.state       ][INFO    ][30643] Running state [ctl02.baremetal-mcp-ocata-odl-ha.local] at time 02:14:30.025989
2017-09-15 02:14:30,026 [salt.state       ][INFO    ][30643] Executing state host.present for ctl02.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:30,027 [salt.state       ][INFO    ][30643] {'host': 'ctl02.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:30,028 [salt.state       ][INFO    ][30643] Completed state [ctl02.baremetal-mcp-ocata-odl-ha.local] at time 02:14:30.028048 duration_in_ms=2.058
2017-09-15 02:14:30,028 [salt.state       ][INFO    ][30643] Running state [ctl02] at time 02:14:30.028412
2017-09-15 02:14:30,028 [salt.state       ][INFO    ][30643] Executing state host.present for ctl02
2017-09-15 02:14:30,033 [salt.state       ][INFO    ][30643] {'host': 'ctl02'}
2017-09-15 02:14:30,034 [salt.state       ][INFO    ][30643] Completed state [ctl02] at time 02:14:30.034055 duration_in_ms=5.642
2017-09-15 02:14:30,034 [salt.state       ][INFO    ][30643] Running state [ctl03.baremetal-mcp-ocata-odl-ha.local] at time 02:14:30.034404
2017-09-15 02:14:30,034 [salt.state       ][INFO    ][30643] Executing state host.present for ctl03.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:30,039 [salt.state       ][INFO    ][30643] {'host': 'ctl03.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:30,040 [salt.state       ][INFO    ][30643] Completed state [ctl03.baremetal-mcp-ocata-odl-ha.local] at time 02:14:30.040094 duration_in_ms=5.691
2017-09-15 02:14:30,040 [salt.state       ][INFO    ][30643] Running state [ctl03] at time 02:14:30.040470
2017-09-15 02:14:30,040 [salt.state       ][INFO    ][30643] Executing state host.present for ctl03
2017-09-15 02:14:30,052 [salt.state       ][INFO    ][30643] {'host': 'ctl03'}
2017-09-15 02:14:30,052 [salt.state       ][INFO    ][30643] Completed state [ctl03] at time 02:14:30.052362 duration_in_ms=11.891
2017-09-15 02:14:30,052 [salt.state       ][INFO    ][30643] Running state [ctl01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:30.052740
2017-09-15 02:14:30,053 [salt.state       ][INFO    ][30643] Executing state host.present for ctl01.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:30,057 [salt.state       ][INFO    ][30643] {'host': 'ctl01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:30,058 [salt.state       ][INFO    ][30643] Completed state [ctl01.baremetal-mcp-ocata-odl-ha.local] at time 02:14:30.058017 duration_in_ms=5.277
2017-09-15 02:14:30,058 [salt.state       ][INFO    ][30643] Running state [ctl01] at time 02:14:30.058387
2017-09-15 02:14:30,058 [salt.state       ][INFO    ][30643] Executing state host.present for ctl01
2017-09-15 02:14:30,063 [salt.state       ][INFO    ][30643] {'host': 'ctl01'}
2017-09-15 02:14:30,064 [salt.state       ][INFO    ][30643] Completed state [ctl01] at time 02:14:30.064118 duration_in_ms=5.73
2017-09-15 02:14:30,064 [salt.state       ][INFO    ][30643] Running state [ctl] at time 02:14:30.064482
2017-09-15 02:14:30,064 [salt.state       ][INFO    ][30643] Executing state host.present for ctl
2017-09-15 02:14:30,069 [salt.state       ][INFO    ][30643] {'host': 'ctl'}
2017-09-15 02:14:30,070 [salt.state       ][INFO    ][30643] Completed state [ctl] at time 02:14:30.070053 duration_in_ms=5.57
2017-09-15 02:14:30,070 [salt.state       ][INFO    ][30643] Running state [ctl.baremetal-mcp-ocata-odl-ha.local] at time 02:14:30.070422
2017-09-15 02:14:30,070 [salt.state       ][INFO    ][30643] Executing state host.present for ctl.baremetal-mcp-ocata-odl-ha.local
2017-09-15 02:14:30,075 [salt.state       ][INFO    ][30643] {'host': 'ctl.baremetal-mcp-ocata-odl-ha.local'}
2017-09-15 02:14:30,076 [salt.state       ][INFO    ][30643] Completed state [ctl.baremetal-mcp-ocata-odl-ha.local] at time 02:14:30.076024 duration_in_ms=5.602
2017-09-15 02:14:30,077 [salt.state       ][INFO    ][30643] Running state [ens4] at time 02:14:30.077096
2017-09-15 02:14:30,077 [salt.state       ][INFO    ][30643] Executing state network.managed for ens4
2017-09-15 02:14:30,215 [salt.loaded.int.module.cmdmod][INFO    ][30643] Executing command ['ifup', 'ens4'] in directory '/root'
2017-09-15 02:14:30,889 [salt.state       ][INFO    ][30643] {'interface': 'Added network interface.', 'status': 'Interface ens4 is up'}
2017-09-15 02:14:30,890 [salt.state       ][INFO    ][30643] Completed state [ens4] at time 02:14:30.889997 duration_in_ms=812.9
2017-09-15 02:14:30,890 [salt.state       ][INFO    ][30643] Running state [ens3] at time 02:14:30.890506
2017-09-15 02:14:30,890 [salt.state       ][INFO    ][30643] Executing state network.managed for ens3
2017-09-15 02:14:31,333 [salt.state       ][INFO    ][30643] Interface ens3 is up to date.
2017-09-15 02:14:31,333 [salt.state       ][INFO    ][30643] Completed state [ens3] at time 02:14:31.333664 duration_in_ms=443.157
2017-09-15 02:14:31,334 [salt.state       ][INFO    ][30643] Running state [/etc/profile.d/proxy.sh] at time 02:14:31.334048
2017-09-15 02:14:31,334 [salt.state       ][INFO    ][30643] Executing state file.absent for /etc/profile.d/proxy.sh
2017-09-15 02:14:31,334 [salt.state       ][INFO    ][30643] File /etc/profile.d/proxy.sh is not present
2017-09-15 02:14:31,335 [salt.state       ][INFO    ][30643] Completed state [/etc/profile.d/proxy.sh] at time 02:14:31.335213 duration_in_ms=1.158
2017-09-15 02:14:31,335 [salt.state       ][INFO    ][30643] Running state [/etc/apt/apt.conf.d/95proxies] at time 02:14:31.335536
2017-09-15 02:14:31,335 [salt.state       ][INFO    ][30643] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2017-09-15 02:14:31,336 [salt.state       ][INFO    ][30643] File /etc/apt/apt.conf.d/95proxies is not present
2017-09-15 02:14:31,336 [salt.state       ][INFO    ][30643] Completed state [/etc/apt/apt.conf.d/95proxies] at time 02:14:31.336527 duration_in_ms=0.991
2017-09-15 02:14:31,339 [salt.minion      ][INFO    ][30643] Returning information for job: 20170915021352581928
2017-09-15 02:15:15,508 [salt.minion      ][INFO    ][30131] User sudo_ubuntu Executing command state.sls with jid 20170915021515496075
2017-09-15 02:15:15,534 [salt.minion      ][INFO    ][1679] Starting a new job with PID 1679
2017-09-15 02:15:17,987 [salt.state       ][INFO    ][1679] Loading fresh modules for state activity
2017-09-15 02:15:18,039 [salt.fileclient  ][INFO    ][1679] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2017-09-15 02:15:18,065 [salt.fileclient  ][INFO    ][1679] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2017-09-15 02:15:18,092 [salt.fileclient  ][INFO    ][1679] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-09-15 02:15:18,121 [salt.fileclient  ][INFO    ][1679] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2017-09-15 02:15:18,503 [salt.state       ][INFO    ][1679] Running state [ntp] at time 02:15:18.503568
2017-09-15 02:15:18,503 [salt.state       ][INFO    ][1679] Executing state pkg.installed for ntp
2017-09-15 02:15:18,504 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 02:15:18,811 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-15 02:15:20,987 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2017-09-15 02:15:21,024 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'ntp'] in directory '/root'
2017-09-15 02:15:25,599 [salt.minion      ][INFO    ][30131] User sudo_ubuntu Executing command saltutil.find_job with jid 20170915021525589416
2017-09-15 02:15:25,624 [salt.minion      ][INFO    ][2544] Starting a new job with PID 2544
2017-09-15 02:15:25,646 [salt.minion      ][INFO    ][2544] Returning information for job: 20170915021525589416
2017-09-15 02:15:29,870 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 02:15:29,919 [salt.state       ][INFO    ][1679] Made the following changes:
'ntp' changed from 'absent' to '1:4.2.8p4+dfsg-3ubuntu5.6'
'libopts25' changed from 'absent' to '1:5.18.7-3'

2017-09-15 02:15:29,936 [salt.state       ][INFO    ][1679] Loading fresh modules for state activity
2017-09-15 02:15:29,969 [salt.state       ][INFO    ][1679] Completed state [ntp] at time 02:15:29.969542 duration_in_ms=11465.971
2017-09-15 02:15:29,976 [salt.state       ][INFO    ][1679] Running state [/etc/ntp.conf] at time 02:15:29.975988
2017-09-15 02:15:29,977 [salt.state       ][INFO    ][1679] Executing state file.managed for /etc/ntp.conf
2017-09-15 02:15:30,013 [salt.fileclient  ][INFO    ][1679] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2017-09-15 02:15:30,057 [salt.state       ][INFO    ][1679] File changed:
--- 
+++ 
@@ -1,66 +1,24 @@
-# /etc/ntp.conf, configuration for ntpd; see ntp.conf(5) for help
 
-driftfile /var/lib/ntp/ntp.drift
 
-# Enable this if you want statistics to be logged.
-#statsdir /var/log/ntpstats/
+# ntpd will only synchronize your clock.
 
-statistics loopstats peerstats clockstats
-filegen loopstats file loopstats type day enable
-filegen peerstats file peerstats type day enable
-filegen clockstats file clockstats type day enable
+# For details, see:
+# - the ntp.conf man page
+# - http://support.ntp.org/bin/view/Support/GettingStarted
+# - https://wiki.archlinux.org/index.php/Network_Time_Protocol_daemon
 
-# Specify one or more NTP servers.
+# Associate to cloud NTP pool servers
+server 1.pool.ntp.org iburst
+server 0.pool.ntp.org
 
-# Use servers from the NTP Pool Project. Approved by Ubuntu Technical Board
-# on 2011-02-08 (LP: #104525). See http://www.pool.ntp.org/join.html for
-# more information.
-pool 0.ubuntu.pool.ntp.org iburst
-pool 1.ubuntu.pool.ntp.org iburst
-pool 2.ubuntu.pool.ntp.org iburst
-pool 3.ubuntu.pool.ntp.org iburst
-
-# Use Ubuntu's ntp server as a fallback.
-pool ntp.ubuntu.com
-
-# Access control configuration; see /usr/share/doc/ntp-doc/html/accopt.html for
-# details.  The web page <http://support.ntp.org/bin/view/Support/AccessRestrictions>
-# might also be helpful.
-#
-# Note that "restrict" applies to both servers and clients, so a configuration
-# that might be intended to block requests from certain clients could also end
-# up blocking replies from your own upstream servers.
-
-# By default, exchange time with everybody, but don't allow configuration.
-restrict -4 default kod notrap nomodify nopeer noquery limited
-restrict -6 default kod notrap nomodify nopeer noquery limited
-
-# Local users may interrogate the ntp server more closely.
+# Only allow read-only access from localhost
+restrict default noquery nopeer
 restrict 127.0.0.1
 restrict ::1
 
-# Needed for adding pool entries
-restrict source notrap nomodify noquery
-
-# Clients from this (example!) subnet have unlimited access, but only if
-# cryptographically authenticated.
-#restrict 192.168.123.0 mask 255.255.255.0 notrust
+# mode7 is required for collectd monitoring
 
 
-# If you want to provide time to your local subnet, change the next line.
-# (Again, the address is an example only.)
-#broadcast 192.168.123.255
-
-# If you want to listen to time broadcasts on your local subnet, de-comment the
-# next lines.  Please do this only if you trust everybody on the network!
-#disable auth
-#broadcastclient
-
-#Changes recquired to use pps synchonisation as explained in documentation:
-#http://www.ntp.org/ntpfaq/NTP-s-config-adv.htm#AEN3918
-
-#server 127.127.8.1 mode 135 prefer    # Meinberg GPS167 with PPS
-#fudge 127.127.8.1 time1 0.0042        # relative to PPS for my hardware
-
-#server 127.127.22.1                   # ATOM(PPS)
-#fudge 127.127.22.1 flag3 1            # enable PPS API
+# Location of drift file
+driftfile /var/lib/ntp/ntp.drift
+logfile /var/log/ntp.log
2017-09-15 02:15:30,057 [salt.state       ][INFO    ][1679] Completed state [/etc/ntp.conf] at time 02:15:30.057892 duration_in_ms=81.904
2017-09-15 02:15:30,176 [salt.state       ][INFO    ][1679] Running state [ntp] at time 02:15:30.176646
2017-09-15 02:15:30,177 [salt.state       ][INFO    ][1679] Executing state service.running for ntp
2017-09-15 02:15:30,179 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2017-09-15 02:15:30,191 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2017-09-15 02:15:30,201 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2017-09-15 02:15:30,211 [salt.state       ][INFO    ][1679] The service ntp is already running
2017-09-15 02:15:30,212 [salt.state       ][INFO    ][1679] Completed state [ntp] at time 02:15:30.212552 duration_in_ms=35.905
2017-09-15 02:15:30,213 [salt.state       ][INFO    ][1679] Running state [ntp] at time 02:15:30.213005
2017-09-15 02:15:30,213 [salt.state       ][INFO    ][1679] Executing state service.mod_watch for ntp
2017-09-15 02:15:30,214 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2017-09-15 02:15:30,223 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2017-09-15 02:15:30,235 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2017-09-15 02:15:30,294 [salt.state       ][INFO    ][1679] {'ntp': True}
2017-09-15 02:15:30,295 [salt.state       ][INFO    ][1679] Completed state [ntp] at time 02:15:30.295037 duration_in_ms=82.031
2017-09-15 02:15:30,296 [salt.minion      ][INFO    ][1679] Returning information for job: 20170915021515496075
2017-09-15 02:17:36,586 [salt.minion      ][INFO    ][30131] User sudo_ubuntu Executing command state.apply with jid 20170915021736569486
2017-09-15 02:17:36,608 [salt.minion      ][INFO    ][3226] Starting a new job with PID 3226
2017-09-15 02:17:38,100 [salt.state       ][INFO    ][3226] Loading fresh modules for state activity
2017-09-15 02:17:38,126 [salt.fileclient  ][INFO    ][3226] Fetching file from saltenv 'base', ** done ** 'maas/pxe_route.sls'
2017-09-15 02:17:38,139 [salt.state       ][INFO    ][3226] Running state [ens3] at time 02:17:38.139566
2017-09-15 02:17:38,139 [salt.state       ][INFO    ][3226] Executing state network.routes for ens3
2017-09-15 02:17:38,259 [salt.loaded.int.module.cmdmod][INFO    ][3226] Executing command ['systemctl', 'status', 'networking.service', '-n', '0'] in directory '/root'
2017-09-15 02:17:38,280 [salt.loaded.int.module.cmdmod][INFO    ][3226] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'networking.service'] in directory '/root'
2017-09-15 02:17:41,519 [salt.loaded.int.module.cmdmod][INFO    ][3226] Executing command ['systemctl', 'is-enabled', 'networking.service'] in directory '/root'
2017-09-15 02:17:41,539 [salt.loaded.int.module.cmdmod][INFO    ][3226] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'networking.service'] in directory '/root'
2017-09-15 02:17:41,841 [salt.loaded.int.module.cmdmod][ERROR   ][3226] Command '['systemd-run', '--scope', 'systemctl', 'start', 'networking.service']' failed with return code: 1
2017-09-15 02:17:41,842 [salt.loaded.int.module.cmdmod][ERROR   ][3226] output: Running scope as unit run-r63fae8c64d80496bb6621a1d39aee195.scope.
Job for networking.service failed because the control process exited with error code. See "systemctl status networking.service" and "journalctl -xe" for details.
2017-09-15 02:17:41,842 [salt.state       ][INFO    ][3226] {'network_routes': 'Added interface ens3 routes.'}
2017-09-15 02:17:41,843 [salt.state       ][INFO    ][3226] Completed state [ens3] at time 02:17:41.842928 duration_in_ms=3703.36
2017-09-15 02:17:41,844 [salt.minion      ][INFO    ][3226] Returning information for job: 20170915021736569486
2017-09-15 03:13:12,266 [salt.utils.schedule][INFO    ][30131] Running scheduled job: __mine_interval
2017-09-15 03:31:46,289 [salt.minion      ][INFO    ][30131] User root Executing command x509.sign_remote_certificate with jid 20170915033146274634
2017-09-15 03:31:46,313 [salt.minion      ][INFO    ][12925] Starting a new job with PID 12925
2017-09-15 03:31:46,346 [salt.minion      ][INFO    ][12925] Returning information for job: 20170915033146274634
2017-09-15 03:31:46,635 [salt.minion      ][INFO    ][30131] User root Executing command x509.sign_remote_certificate with jid 20170915033146623853
2017-09-15 03:31:46,659 [salt.minion      ][INFO    ][12934] Starting a new job with PID 12934
2017-09-15 03:31:46,719 [salt.minion      ][INFO    ][12934] Returning information for job: 20170915033146623853
2017-09-15 03:31:48,851 [salt.minion      ][INFO    ][30131] User root Executing command x509.sign_remote_certificate with jid 20170915033148845832
2017-09-15 03:31:48,868 [salt.minion      ][INFO    ][12943] Starting a new job with PID 12943
2017-09-15 03:31:48,891 [salt.minion      ][INFO    ][12943] Returning information for job: 20170915033148845832
2017-09-15 03:31:49,209 [salt.minion      ][INFO    ][30131] User root Executing command x509.sign_remote_certificate with jid 20170915033149198207
2017-09-15 03:31:49,254 [salt.minion      ][INFO    ][12952] Starting a new job with PID 12952
2017-09-15 03:31:49,316 [salt.minion      ][INFO    ][12952] Returning information for job: 20170915033149198207
2017-09-15 04:13:12,266 [salt.utils.schedule][INFO    ][30131] Running scheduled job: __mine_interval
2017-09-15 04:56:35,286 [salt.minion      ][INFO    ][30131] User sudo_ubuntu Executing command cp.push_dir with jid 20170915045635275108
2017-09-15 04:56:35,308 [salt.minion      ][INFO    ][18795] Starting a new job with PID 18795
