2017-12-10 09:55:08,994 [salt.cli.daemons ][WARNING ][892] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-10 10:00:20,632 [salt.state       ][ERROR   ][1162] No contents found in top file
2017-12-10 10:00:29,630 [py.warnings      ][WARNING ][1259] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-12-10 10:00:44,739 [salt.loaded.int.module.cmdmod][ERROR   ][1259] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-12-10 10:00:46,656 [salt.loaded.int.module.cmdmod][INFO    ][1738] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-10 10:00:46,664 [salt.loaded.int.module.cmdmod][INFO    ][1738] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-10 10:00:46,676 [salt.loaded.int.module.cmdmod][INFO    ][1738] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-10 10:00:46,709 [salt.utils.parsers][WARNING ][892] Minion received a SIGTERM. Exiting.
2017-12-10 10:00:47,026 [salt.cli.daemons ][INFO    ][1794] Setting up the Salt Minion "odl01.baremetal-mcp-ocata-odl-ha.local"
2017-12-10 10:00:47,377 [salt.minion      ][INFO    ][1794] Creating minion process manager
2017-12-10 10:00:47,378 [salt.cli.daemons ][WARNING ][1794] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-10 10:00:47,378 [salt.cli.daemons ][INFO    ][1794] The Salt Minion is starting up
2017-12-10 10:00:47,378 [salt.minion      ][INFO    ][1794] Minion is starting as user 'root'
2017-12-10 10:00:47,379 [salt.utils.event ][INFO    ][1794] Starting pull socket on /var/run/salt/minion/minion_event_c4ab45d64e_pull.ipc
2017-12-10 10:00:48,762 [salt.loaded.int.module.cmdmod][INFO    ][1794] Executing command ['date', '+%z'] in directory '/root'
2017-12-10 10:00:48,778 [salt.utils.schedule][INFO    ][1794] Updating job settings for scheduled job: __mine_interval
2017-12-10 10:00:48,784 [salt.minion      ][INFO    ][1794] Added mine.update to scheduler
2017-12-10 10:00:48,818 [salt.minion      ][INFO    ][1794] Minion is ready to receive requests!
2017-12-10 10:00:49,820 [salt.utils.schedule][INFO    ][1794] Running scheduled job: __mine_interval
2017-12-10 10:00:53,869 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command state.apply with jid 20171210100053850138
2017-12-10 10:00:53,889 [salt.minion      ][INFO    ][1885] Starting a new job with PID 1885
2017-12-10 10:00:57,629 [salt.state       ][INFO    ][1885] Loading fresh modules for state activity
2017-12-10 10:00:57,865 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2017-12-10 10:00:57,929 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2017-12-10 10:00:57,966 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:58,027 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2017-12-10 10:00:58,044 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:58,101 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2017-12-10 10:00:58,117 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:58,385 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2017-12-10 10:00:58,458 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:58,595 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2017-12-10 10:00:58,630 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:58,702 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2017-12-10 10:00:58,720 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:58,787 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2017-12-10 10:00:58,835 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:58,921 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2017-12-10 10:00:58,943 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:59,015 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2017-12-10 10:00:59,039 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:59,102 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2017-12-10 10:00:59,124 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:59,192 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2017-12-10 10:00:59,244 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:59,366 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2017-12-10 10:00:59,399 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:59,463 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2017-12-10 10:00:59,488 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:59,552 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2017-12-10 10:00:59,574 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:59,642 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2017-12-10 10:00:59,663 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:59,724 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2017-12-10 10:00:59,743 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:59,806 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2017-12-10 10:00:59,845 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:00:59,944 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2017-12-10 10:01:00,034 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:01:00,096 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2017-12-10 10:01:00,113 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:01:00,176 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2017-12-10 10:01:00,199 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:01:00,373 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2017-12-10 10:01:00,394 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2017-12-10 10:01:00,412 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-10 10:01:00,434 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2017-12-10 10:01:00,460 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-10 10:01:00,479 [salt.state       ][INFO    ][1885] Running state [/etc/environment] at time 10:01:00.479201
2017-12-10 10:01:00,480 [salt.state       ][INFO    ][1885] Executing state file.blockreplace for /etc/environment
2017-12-10 10:01:00,486 [salt.state       ][INFO    ][1885] 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-12-10 10:01:00,487 [salt.state       ][INFO    ][1885] Completed state [/etc/environment] at time 10:01:00.487031 duration_in_ms=7.83
2017-12-10 10:01:00,487 [salt.state       ][INFO    ][1885] Running state [/etc/profile.d] at time 10:01:00.487384
2017-12-10 10:01:00,488 [salt.state       ][INFO    ][1885] Executing state file.directory for /etc/profile.d
2017-12-10 10:01:00,489 [salt.state       ][INFO    ][1885] Directory /etc/profile.d is in the correct state
2017-12-10 10:01:00,489 [salt.state       ][INFO    ][1885] Completed state [/etc/profile.d] at time 10:01:00.489375 duration_in_ms=1.99
2017-12-10 10:01:00,806 [salt.state       ][INFO    ][1885] Running state [linux_repo_prereq_pkgs] at time 10:01:00.806441
2017-12-10 10:01:00,807 [salt.state       ][INFO    ][1885] Executing state pkg.installed for linux_repo_prereq_pkgs
2017-12-10 10:01:00,808 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:01:01,350 [salt.state       ][INFO    ][1885] All specified packages are already installed
2017-12-10 10:01:01,350 [salt.state       ][INFO    ][1885] Completed state [linux_repo_prereq_pkgs] at time 10:01:01.350443 duration_in_ms=544.002
2017-12-10 10:01:01,351 [salt.state       ][INFO    ][1885] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 10:01:01.350824
2017-12-10 10:01:01,351 [salt.state       ][INFO    ][1885] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mk_openstack
2017-12-10 10:01:01,352 [salt.state       ][INFO    ][1885] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2017-12-10 10:01:01,352 [salt.state       ][INFO    ][1885] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 10:01:01.351940 duration_in_ms=1.117
2017-12-10 10:01:01,352 [salt.state       ][INFO    ][1885] Running state [/etc/apt/preferences.d/mk_openstack] at time 10:01:01.352283
2017-12-10 10:01:01,353 [salt.state       ][INFO    ][1885] Executing state file.managed for /etc/apt/preferences.d/mk_openstack
2017-12-10 10:01:01,370 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-12-10 10:01:01,389 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:01:01,443 [salt.state       ][INFO    ][1885] File changed:
New file
2017-12-10 10:01:01,444 [salt.state       ][INFO    ][1885] Completed state [/etc/apt/preferences.d/mk_openstack] at time 10:01:01.444040 duration_in_ms=91.756
2017-12-10 10:01:01,447 [salt.state       ][INFO    ][1885] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly ocata] at time 10:01:01.447375
2017-12-10 10:01:01,448 [salt.state       ][INFO    ][1885] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly ocata
2017-12-10 10:01:01,783 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
2017-12-10 10:01:01,918 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-10 10:01:03,992 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100103964129
2017-12-10 10:01:04,005 [salt.state       ][INFO    ][1885] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly ocata'}
2017-12-10 10:01:04,006 [salt.minion      ][INFO    ][2349] Starting a new job with PID 2349
2017-12-10 10:01:04,006 [salt.state       ][INFO    ][1885] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly ocata] at time 10:01:04.006149 duration_in_ms=2558.774
2017-12-10 10:01:04,007 [salt.state       ][INFO    ][1885] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 10:01:04.006694
2017-12-10 10:01:04,007 [salt.state       ][INFO    ][1885] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack
2017-12-10 10:01:04,008 [salt.state       ][INFO    ][1885] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2017-12-10 10:01:04,008 [salt.state       ][INFO    ][1885] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 10:01:04.007908 duration_in_ms=1.214
2017-12-10 10:01:04,008 [salt.state       ][INFO    ][1885] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 10:01:04.008259
2017-12-10 10:01:04,009 [salt.state       ][INFO    ][1885] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack
2017-12-10 10:01:04,020 [salt.minion      ][INFO    ][2349] Returning information for job: 20171210100103964129
2017-12-10 10:01:04,044 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-12-10 10:01:04,063 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:01:04,118 [salt.state       ][INFO    ][1885] File changed:
New file
2017-12-10 10:01:04,119 [salt.state       ][INFO    ][1885] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 10:01:04.118591 duration_in_ms=110.331
2017-12-10 10:01:04,120 [salt.state       ][INFO    ][1885] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main] at time 10:01:04.119735
2017-12-10 10:01:04,120 [salt.state       ][INFO    ][1885] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main
2017-12-10 10:01:05,511 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/ocata/xenial/archive-mcpocata.key'] in directory '/root'
2017-12-10 10:01:05,617 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-10 10:01:07,619 [salt.state       ][INFO    ][1885] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main'}
2017-12-10 10:01:07,619 [salt.state       ][INFO    ][1885] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main] at time 10:01:07.619268 duration_in_ms=3499.531
2017-12-10 10:01:07,620 [salt.state       ][INFO    ][1885] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 10:01:07.619759
2017-12-10 10:01:07,620 [salt.state       ][INFO    ][1885] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2017-12-10 10:01:07,621 [salt.state       ][INFO    ][1885] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2017-12-10 10:01:07,621 [salt.state       ][INFO    ][1885] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 10:01:07.621106 duration_in_ms=1.347
2017-12-10 10:01:07,622 [salt.state       ][INFO    ][1885] Running state [/etc/apt/preferences.d/uca] at time 10:01:07.621475
2017-12-10 10:01:07,622 [salt.state       ][INFO    ][1885] Executing state file.absent for /etc/apt/preferences.d/uca
2017-12-10 10:01:07,622 [salt.state       ][INFO    ][1885] File /etc/apt/preferences.d/uca is not present
2017-12-10 10:01:07,623 [salt.state       ][INFO    ][1885] Completed state [/etc/apt/preferences.d/uca] at time 10:01:07.622610 duration_in_ms=1.135
2017-12-10 10:01:07,624 [salt.state       ][INFO    ][1885] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 10:01:07.623766
2017-12-10 10:01:07,624 [salt.state       ][INFO    ][1885] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main
2017-12-10 10:01:07,695 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['apt-key', 'export', 'EC4926EA'] in directory '/root'
2017-12-10 10:01:07,746 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['apt-key', 'adv', '--keyserver', 'keyserver.ubuntu.com', '--logger-fd', '1', '--recv-keys', 'EC4926EA'] in directory '/root'
2017-12-10 10:01:07,966 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-10 10:01:10,565 [salt.state       ][INFO    ][1885] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main'}
2017-12-10 10:01:10,566 [salt.state       ][INFO    ][1885] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 10:01:10.565847 duration_in_ms=2942.08
2017-12-10 10:01:10,566 [salt.state       ][INFO    ][1885] Running state [/etc/apt/apt.conf.d/99proxies-salt-mcp_extra] at time 10:01:10.566265
2017-12-10 10:01:10,567 [salt.state       ][INFO    ][1885] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mcp_extra
2017-12-10 10:01:10,567 [salt.state       ][INFO    ][1885] File /etc/apt/apt.conf.d/99proxies-salt-mcp_extra is not present
2017-12-10 10:01:10,568 [salt.state       ][INFO    ][1885] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mcp_extra] at time 10:01:10.567500 duration_in_ms=1.235
2017-12-10 10:01:10,568 [salt.state       ][INFO    ][1885] Running state [/etc/apt/preferences.d/mcp_extra] at time 10:01:10.567864
2017-12-10 10:01:10,568 [salt.state       ][INFO    ][1885] Executing state file.managed for /etc/apt/preferences.d/mcp_extra
2017-12-10 10:01:10,586 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-12-10 10:01:10,608 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:01:10,662 [salt.state       ][INFO    ][1885] File changed:
New file
2017-12-10 10:01:10,663 [salt.state       ][INFO    ][1885] Completed state [/etc/apt/preferences.d/mcp_extra] at time 10:01:10.662996 duration_in_ms=95.13
2017-12-10 10:01:10,664 [salt.state       ][INFO    ][1885] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly extra] at time 10:01:10.664077
2017-12-10 10:01:10,664 [salt.state       ][INFO    ][1885] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly extra
2017-12-10 10:01:10,799 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
2017-12-10 10:01:10,895 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-10 10:01:12,832 [salt.state       ][INFO    ][1885] Configured package repo 'deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly extra'
2017-12-10 10:01:12,833 [salt.state       ][INFO    ][1885] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly extra] at time 10:01:12.832692 duration_in_ms=2168.615
2017-12-10 10:01:12,833 [salt.state       ][INFO    ][1885] Running state [linux_extra_packages_purged] at time 10:01:12.833144
2017-12-10 10:01:12,834 [salt.state       ][INFO    ][1885] Executing state pkg.purged for linux_extra_packages_purged
2017-12-10 10:01:12,852 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', 'purge', 'cloud-init', 'unattended-upgrades'] in directory '/root'
2017-12-10 10:01:14,208 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100114183808
2017-12-10 10:01:14,223 [salt.minion      ][INFO    ][3835] Starting a new job with PID 3835
2017-12-10 10:01:14,237 [salt.minion      ][INFO    ][3835] Returning information for job: 20171210100114183808
2017-12-10 10:01:16,283 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:01:16,309 [salt.state       ][INFO    ][1885] {'removed': {}, 'installed': {'cloud-init': {'new': '', 'old': '0.7.9-233-ge586fe35-0ubuntu1~16.04.1'}, 'ec2-init': {'new': '', 'old': '1'}, 'unattended-upgrades': {'new': '', 'old': '0.90ubuntu0.8'}}}
2017-12-10 10:01:16,323 [salt.state       ][INFO    ][1885] Loading fresh modules for state activity
2017-12-10 10:01:16,344 [salt.state       ][INFO    ][1885] Completed state [linux_extra_packages_purged] at time 10:01:16.343488 duration_in_ms=3510.343
2017-12-10 10:01:16,351 [salt.state       ][INFO    ][1885] Running state [linux_extra_packages_latest] at time 10:01:16.350473
2017-12-10 10:01:16,351 [salt.state       ][INFO    ][1885] Executing state pkg.latest for linux_extra_packages_latest
2017-12-10 10:01:16,617 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-10 10:01:18,645 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['apt-cache', '-q', 'policy', 'mcelog'] in directory '/root'
2017-12-10 10:01:18,692 [salt.loaded.int.module.cmdmod][INFO    ][1885] 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-12-10 10:01:20,741 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:01:20,767 [salt.state       ][INFO    ][1885] Made the following changes:
'mcelog' changed from 'absent' to '128+dfsg-1'

2017-12-10 10:01:20,778 [salt.state       ][INFO    ][1885] Loading fresh modules for state activity
2017-12-10 10:01:20,799 [salt.state       ][INFO    ][1885] Completed state [linux_extra_packages_latest] at time 10:01:20.798566 duration_in_ms=4448.092
2017-12-10 10:01:20,805 [salt.state       ][INFO    ][1885] Running state [UTC] at time 10:01:20.804827
2017-12-10 10:01:20,805 [salt.state       ][INFO    ][1885] Executing state timezone.system for UTC
2017-12-10 10:01:20,807 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['timedatectl'] in directory '/root'
2017-12-10 10:01:20,872 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['timedatectl'] in directory '/root'
2017-12-10 10:01:20,881 [salt.state       ][INFO    ][1885] Timezone UTC already set, UTC already set to UTC
2017-12-10 10:01:20,881 [salt.state       ][INFO    ][1885] Completed state [UTC] at time 10:01:20.881160 duration_in_ms=76.332
2017-12-10 10:01:20,885 [salt.state       ][INFO    ][1885] Running state [nf_conntrack] at time 10:01:20.884458
2017-12-10 10:01:20,885 [salt.state       ][INFO    ][1885] Executing state kmod.present for nf_conntrack
2017-12-10 10:01:20,886 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'lsmod' in directory '/root'
2017-12-10 10:01:21,299 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'lsmod' in directory '/root'
2017-12-10 10:01:21,308 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'modprobe nf_conntrack' in directory '/root'
2017-12-10 10:01:21,318 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'lsmod' in directory '/root'
2017-12-10 10:01:21,378 [salt.state       ][INFO    ][1885] {'nf_conntrack': 'loaded'}
2017-12-10 10:01:21,378 [salt.state       ][INFO    ][1885] Completed state [nf_conntrack] at time 10:01:21.377878 duration_in_ms=493.421
2017-12-10 10:01:21,381 [salt.state       ][INFO    ][1885] Running state [kernel.panic] at time 10:01:21.381033
2017-12-10 10:01:21,381 [salt.state       ][INFO    ][1885] Executing state sysctl.present for kernel.panic
2017-12-10 10:01:21,382 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,432 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2017-12-10 10:01:21,441 [salt.state       ][INFO    ][1885] {'kernel.panic': 60}
2017-12-10 10:01:21,442 [salt.state       ][INFO    ][1885] Completed state [kernel.panic] at time 10:01:21.441726 duration_in_ms=60.692
2017-12-10 10:01:21,442 [salt.state       ][INFO    ][1885] Running state [net.ipv4.tcp_keepalive_probes] at time 10:01:21.442038
2017-12-10 10:01:21,442 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2017-12-10 10:01:21,443 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,459 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2017-12-10 10:01:21,468 [salt.state       ][INFO    ][1885] {'net.ipv4.tcp_keepalive_probes': 8}
2017-12-10 10:01:21,469 [salt.state       ][INFO    ][1885] Completed state [net.ipv4.tcp_keepalive_probes] at time 10:01:21.468487 duration_in_ms=26.448
2017-12-10 10:01:21,469 [salt.state       ][INFO    ][1885] Running state [fs.file-max] at time 10:01:21.468787
2017-12-10 10:01:21,469 [salt.state       ][INFO    ][1885] Executing state sysctl.present for fs.file-max
2017-12-10 10:01:21,470 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,488 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2017-12-10 10:01:21,496 [salt.state       ][INFO    ][1885] {'fs.file-max': 124165}
2017-12-10 10:01:21,497 [salt.state       ][INFO    ][1885] Completed state [fs.file-max] at time 10:01:21.496739 duration_in_ms=27.951
2017-12-10 10:01:21,497 [salt.state       ][INFO    ][1885] Running state [net.core.somaxconn] at time 10:01:21.497053
2017-12-10 10:01:21,497 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.core.somaxconn
2017-12-10 10:01:21,498 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,515 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2017-12-10 10:01:21,523 [salt.state       ][INFO    ][1885] {'net.core.somaxconn': 4096}
2017-12-10 10:01:21,524 [salt.state       ][INFO    ][1885] Completed state [net.core.somaxconn] at time 10:01:21.523861 duration_in_ms=26.808
2017-12-10 10:01:21,524 [salt.state       ][INFO    ][1885] Running state [net.ipv4.tcp_max_syn_backlog] at time 10:01:21.524318
2017-12-10 10:01:21,525 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2017-12-10 10:01:21,526 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,543 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2017-12-10 10:01:21,551 [salt.state       ][INFO    ][1885] {'net.ipv4.tcp_max_syn_backlog': 8192}
2017-12-10 10:01:21,552 [salt.state       ][INFO    ][1885] Completed state [net.ipv4.tcp_max_syn_backlog] at time 10:01:21.551468 duration_in_ms=27.149
2017-12-10 10:01:21,552 [salt.state       ][INFO    ][1885] Running state [net.ipv4.tcp_tw_reuse] at time 10:01:21.551938
2017-12-10 10:01:21,552 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2017-12-10 10:01:21,553 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,569 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2017-12-10 10:01:21,576 [salt.state       ][INFO    ][1885] {'net.ipv4.tcp_tw_reuse': 1}
2017-12-10 10:01:21,576 [salt.state       ][INFO    ][1885] Completed state [net.ipv4.tcp_tw_reuse] at time 10:01:21.576391 duration_in_ms=24.452
2017-12-10 10:01:21,577 [salt.state       ][INFO    ][1885] Running state [net.ipv4.tcp_congestion_control] at time 10:01:21.576876
2017-12-10 10:01:21,577 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2017-12-10 10:01:21,578 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,593 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2017-12-10 10:01:21,605 [salt.state       ][INFO    ][1885] {'net.ipv4.tcp_congestion_control': 'yeah'}
2017-12-10 10:01:21,605 [salt.state       ][INFO    ][1885] Completed state [net.ipv4.tcp_congestion_control] at time 10:01:21.605294 duration_in_ms=28.417
2017-12-10 10:01:21,606 [salt.state       ][INFO    ][1885] Running state [net.ipv4.tcp_retries2] at time 10:01:21.605785
2017-12-10 10:01:21,606 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.ipv4.tcp_retries2
2017-12-10 10:01:21,607 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,624 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2017-12-10 10:01:21,633 [salt.state       ][INFO    ][1885] {'net.ipv4.tcp_retries2': 5}
2017-12-10 10:01:21,633 [salt.state       ][INFO    ][1885] Completed state [net.ipv4.tcp_retries2] at time 10:01:21.633371 duration_in_ms=27.585
2017-12-10 10:01:21,634 [salt.state       ][INFO    ][1885] Running state [net.core.netdev_max_backlog] at time 10:01:21.633859
2017-12-10 10:01:21,634 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.core.netdev_max_backlog
2017-12-10 10:01:21,635 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,650 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2017-12-10 10:01:21,656 [salt.state       ][INFO    ][1885] {'net.core.netdev_max_backlog': 261144}
2017-12-10 10:01:21,656 [salt.state       ][INFO    ][1885] Completed state [net.core.netdev_max_backlog] at time 10:01:21.656252 duration_in_ms=22.392
2017-12-10 10:01:21,657 [salt.state       ][INFO    ][1885] Running state [net.ipv4.tcp_slow_start_after_idle] at time 10:01:21.656702
2017-12-10 10:01:21,657 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2017-12-10 10:01:21,658 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,672 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2017-12-10 10:01:21,679 [salt.state       ][INFO    ][1885] {'net.ipv4.tcp_slow_start_after_idle': 0}
2017-12-10 10:01:21,680 [salt.state       ][INFO    ][1885] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 10:01:21.679709 duration_in_ms=23.006
2017-12-10 10:01:21,680 [salt.state       ][INFO    ][1885] Running state [vm.swappiness] at time 10:01:21.680169
2017-12-10 10:01:21,681 [salt.state       ][INFO    ][1885] Executing state sysctl.present for vm.swappiness
2017-12-10 10:01:21,681 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,696 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2017-12-10 10:01:21,704 [salt.state       ][INFO    ][1885] {'vm.swappiness': 10}
2017-12-10 10:01:21,705 [salt.state       ][INFO    ][1885] Completed state [vm.swappiness] at time 10:01:21.704657 duration_in_ms=24.487
2017-12-10 10:01:21,705 [salt.state       ][INFO    ][1885] Running state [net.ipv4.tcp_keepalive_intvl] at time 10:01:21.705146
2017-12-10 10:01:21,706 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2017-12-10 10:01:21,706 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,722 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2017-12-10 10:01:21,728 [salt.state       ][INFO    ][1885] {'net.ipv4.tcp_keepalive_intvl': 3}
2017-12-10 10:01:21,729 [salt.state       ][INFO    ][1885] Completed state [net.ipv4.tcp_keepalive_intvl] at time 10:01:21.728608 duration_in_ms=23.462
2017-12-10 10:01:21,729 [salt.state       ][INFO    ][1885] Running state [net.ipv4.neigh.default.gc_thresh1] at time 10:01:21.729108
2017-12-10 10:01:21,730 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2017-12-10 10:01:21,730 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,745 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2017-12-10 10:01:21,751 [salt.state       ][INFO    ][1885] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2017-12-10 10:01:21,752 [salt.state       ][INFO    ][1885] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 10:01:21.751789 duration_in_ms=22.68
2017-12-10 10:01:21,752 [salt.state       ][INFO    ][1885] Running state [net.ipv4.neigh.default.gc_thresh2] at time 10:01:21.752266
2017-12-10 10:01:21,753 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2017-12-10 10:01:21,753 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,769 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2017-12-10 10:01:21,775 [salt.state       ][INFO    ][1885] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2017-12-10 10:01:21,776 [salt.state       ][INFO    ][1885] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 10:01:21.775642 duration_in_ms=23.375
2017-12-10 10:01:21,776 [salt.state       ][INFO    ][1885] Running state [net.ipv4.neigh.default.gc_thresh3] at time 10:01:21.775966
2017-12-10 10:01:21,776 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2017-12-10 10:01:21,777 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,792 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2017-12-10 10:01:21,799 [salt.state       ][INFO    ][1885] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2017-12-10 10:01:21,799 [salt.state       ][INFO    ][1885] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 10:01:21.799253 duration_in_ms=23.287
2017-12-10 10:01:21,800 [salt.state       ][INFO    ][1885] Running state [net.ipv4.tcp_fin_timeout] at time 10:01:21.799589
2017-12-10 10:01:21,800 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2017-12-10 10:01:21,801 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,817 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2017-12-10 10:01:21,824 [salt.state       ][INFO    ][1885] {'net.ipv4.tcp_fin_timeout': 30}
2017-12-10 10:01:21,824 [salt.state       ][INFO    ][1885] Completed state [net.ipv4.tcp_fin_timeout] at time 10:01:21.823829 duration_in_ms=24.238
2017-12-10 10:01:21,824 [salt.state       ][INFO    ][1885] Running state [net.ipv4.tcp_keepalive_time] at time 10:01:21.824160
2017-12-10 10:01:21,825 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2017-12-10 10:01:21,825 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,840 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2017-12-10 10:01:21,846 [salt.state       ][INFO    ][1885] {'net.ipv4.tcp_keepalive_time': 30}
2017-12-10 10:01:21,846 [salt.state       ][INFO    ][1885] Completed state [net.ipv4.tcp_keepalive_time] at time 10:01:21.845840 duration_in_ms=21.679
2017-12-10 10:01:21,846 [salt.state       ][INFO    ][1885] Running state [net.nf_conntrack_max] at time 10:01:21.846187
2017-12-10 10:01:21,847 [salt.state       ][INFO    ][1885] Executing state sysctl.present for net.nf_conntrack_max
2017-12-10 10:01:21,847 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -a' in directory '/root'
2017-12-10 10:01:21,862 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2017-12-10 10:01:21,868 [salt.state       ][INFO    ][1885] {'net.nf_conntrack_max': 1048576}
2017-12-10 10:01:21,868 [salt.state       ][INFO    ][1885] Completed state [net.nf_conntrack_max] at time 10:01:21.867910 duration_in_ms=21.723
2017-12-10 10:01:21,874 [salt.state       ][INFO    ][1885] Running state [linux_sysfs_package] at time 10:01:21.874283
2017-12-10 10:01:21,875 [salt.state       ][INFO    ][1885] Executing state pkg.installed for linux_sysfs_package
2017-12-10 10:01:22,123 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2017-12-10 10:01:22,173 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-10 10:01:24,223 [salt.loaded.int.module.cmdmod][INFO    ][1885] 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-12-10 10:01:24,422 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100124396920
2017-12-10 10:01:24,435 [salt.minion      ][INFO    ][5189] Starting a new job with PID 5189
2017-12-10 10:01:24,448 [salt.minion      ][INFO    ][5189] Returning information for job: 20171210100124396920
2017-12-10 10:01:26,193 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:01:26,218 [salt.state       ][INFO    ][1885] 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-12-10 10:01:26,229 [salt.state       ][INFO    ][1885] Loading fresh modules for state activity
2017-12-10 10:01:26,247 [salt.state       ][INFO    ][1885] Completed state [linux_sysfs_package] at time 10:01:26.246920 duration_in_ms=4372.636
2017-12-10 10:01:26,250 [salt.state       ][INFO    ][1885] Running state [/etc/sysfs.d] at time 10:01:26.250278
2017-12-10 10:01:26,251 [salt.state       ][INFO    ][1885] Executing state file.directory for /etc/sysfs.d
2017-12-10 10:01:26,253 [salt.state       ][INFO    ][1885] Directory /etc/sysfs.d is in the correct state
2017-12-10 10:01:26,254 [salt.state       ][INFO    ][1885] Completed state [/etc/sysfs.d] at time 10:01:26.253731 duration_in_ms=3.453
2017-12-10 10:01:26,337 [salt.state       ][INFO    ][1885] Running state [ondemand] at time 10:01:26.337414
2017-12-10 10:01:26,338 [salt.state       ][INFO    ][1885] Executing state service.dead for ondemand
2017-12-10 10:01:26,341 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2017-12-10 10:01:26,351 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2017-12-10 10:01:26,361 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-12-10 10:01:26,372 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2017-12-10 10:01:26,422 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2017-12-10 10:01:26,432 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-12-10 10:01:26,444 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-12-10 10:01:26,460 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2017-12-10 10:01:26,571 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-12-10 10:01:26,587 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'runlevel' in directory '/root'
2017-12-10 10:01:26,595 [salt.state       ][INFO    ][1885] {'ondemand': True}
2017-12-10 10:01:26,595 [salt.state       ][INFO    ][1885] Completed state [ondemand] at time 10:01:26.595117 duration_in_ms=257.703
2017-12-10 10:01:26,597 [salt.state       ][INFO    ][1885] Running state [cs_CZ.UTF-8] at time 10:01:26.596878
2017-12-10 10:01:26,597 [salt.state       ][INFO    ][1885] Executing state locale.present for cs_CZ.UTF-8
2017-12-10 10:01:26,598 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'locale -a' in directory '/root'
2017-12-10 10:01:26,609 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['locale-gen', 'cs_CZ.UTF-8'] in directory '/root'
2017-12-10 10:01:27,271 [salt.state       ][INFO    ][1885] {'locale': 'cs_CZ.UTF-8'}
2017-12-10 10:01:27,271 [salt.state       ][INFO    ][1885] Completed state [cs_CZ.UTF-8] at time 10:01:27.270988 duration_in_ms=674.109
2017-12-10 10:01:27,272 [salt.state       ][INFO    ][1885] Running state [en_US.UTF-8] at time 10:01:27.271482
2017-12-10 10:01:27,272 [salt.state       ][INFO    ][1885] Executing state locale.present for en_US.UTF-8
2017-12-10 10:01:27,273 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'locale -a' in directory '/root'
2017-12-10 10:01:27,281 [salt.state       ][INFO    ][1885] Locale en_US.UTF-8 is already present
2017-12-10 10:01:27,282 [salt.state       ][INFO    ][1885] Completed state [en_US.UTF-8] at time 10:01:27.282096 duration_in_ms=10.613
2017-12-10 10:01:27,284 [salt.state       ][INFO    ][1885] Running state [en_US.UTF-8] at time 10:01:27.283666
2017-12-10 10:01:27,284 [salt.state       ][INFO    ][1885] Executing state locale.system for en_US.UTF-8
2017-12-10 10:01:27,285 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'localectl' in directory '/root'
2017-12-10 10:01:27,337 [salt.state       ][INFO    ][1885] System locale en_US.UTF-8 already set
2017-12-10 10:01:27,338 [salt.state       ][INFO    ][1885] Completed state [en_US.UTF-8] at time 10:01:27.337917 duration_in_ms=54.249
2017-12-10 10:01:27,341 [salt.state       ][INFO    ][1885] Running state [root] at time 10:01:27.340501
2017-12-10 10:01:27,341 [salt.state       ][INFO    ][1885] Executing state user.present for root
2017-12-10 10:01:27,349 [salt.state       ][INFO    ][1885] {'passwd': 'XXX-REDACTED-XXX', 'lstchg': 17510}
2017-12-10 10:01:27,349 [salt.state       ][INFO    ][1885] Completed state [root] at time 10:01:27.349188 duration_in_ms=8.687
2017-12-10 10:01:27,351 [salt.state       ][INFO    ][1885] Running state [/root] at time 10:01:27.350614
2017-12-10 10:01:27,351 [salt.state       ][INFO    ][1885] Executing state file.directory for /root
2017-12-10 10:01:27,352 [salt.state       ][INFO    ][1885] Directory /root is in the correct state
2017-12-10 10:01:27,352 [salt.state       ][INFO    ][1885] Completed state [/root] at time 10:01:27.352436 duration_in_ms=1.821
2017-12-10 10:01:27,353 [salt.state       ][INFO    ][1885] Running state [/etc/sudoers.d/90-salt-user-root] at time 10:01:27.353054
2017-12-10 10:01:27,354 [salt.state       ][INFO    ][1885] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2017-12-10 10:01:27,355 [salt.state       ][INFO    ][1885] File /etc/sudoers.d/90-salt-user-root is not present
2017-12-10 10:01:27,355 [salt.state       ][INFO    ][1885] Completed state [/etc/sudoers.d/90-salt-user-root] at time 10:01:27.354884 duration_in_ms=1.83
2017-12-10 10:01:27,355 [salt.state       ][INFO    ][1885] Running state [ubuntu] at time 10:01:27.355239
2017-12-10 10:01:27,356 [salt.state       ][INFO    ][1885] Executing state user.present for ubuntu
2017-12-10 10:01:27,356 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['useradd', '-s', '/bin/bash', '-m', '-d', '/home/ubuntu', 'ubuntu'] in directory '/root'
2017-12-10 10:01:27,405 [salt.state       ][INFO    ][1885] {'shell': '/bin/bash', 'workphone': '', 'uid': 1000, 'passwd': 'x', 'roomnumber': '', 'groups': ['ubuntu'], 'home': '/home/ubuntu', 'password': 'XXX-REDACTED-XXX', 'name': 'ubuntu', 'gid': 1000, 'fullname': '', 'homephone': ''}
2017-12-10 10:01:27,406 [salt.state       ][INFO    ][1885] Completed state [ubuntu] at time 10:01:27.405718 duration_in_ms=50.478
2017-12-10 10:01:27,407 [salt.state       ][INFO    ][1885] Running state [/home/ubuntu] at time 10:01:27.407144
2017-12-10 10:01:27,408 [salt.state       ][INFO    ][1885] Executing state file.directory for /home/ubuntu
2017-12-10 10:01:27,409 [salt.state       ][INFO    ][1885] {'mode': '0700'}
2017-12-10 10:01:27,409 [salt.state       ][INFO    ][1885] Completed state [/home/ubuntu] at time 10:01:27.408959 duration_in_ms=1.815
2017-12-10 10:01:27,410 [salt.state       ][INFO    ][1885] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 10:01:27.409985
2017-12-10 10:01:27,410 [salt.state       ][INFO    ][1885] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2017-12-10 10:01:27,431 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2017-12-10 10:01:27,435 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command '/usr/sbin/visudo -c -f /tmp/tmpCtoyk7' in directory '/root'
2017-12-10 10:01:27,451 [salt.state       ][INFO    ][1885] File changed:
New file
2017-12-10 10:01:27,451 [salt.state       ][INFO    ][1885] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 10:01:27.451210 duration_in_ms=41.224
2017-12-10 10:01:27,452 [salt.state       ][INFO    ][1885] Running state [/etc/security/limits.d/90-salt-default.conf] at time 10:01:27.451618
2017-12-10 10:01:27,452 [salt.state       ][INFO    ][1885] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2017-12-10 10:01:27,473 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2017-12-10 10:01:27,498 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:01:27,556 [salt.state       ][INFO    ][1885] File changed:
New file
2017-12-10 10:01:27,556 [salt.state       ][INFO    ][1885] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 10:01:27.556344 duration_in_ms=104.725
2017-12-10 10:01:27,557 [salt.state       ][INFO    ][1885] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 10:01:27.556763
2017-12-10 10:01:27,557 [salt.state       ][INFO    ][1885] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2017-12-10 10:01:27,577 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2017-12-10 10:01:27,601 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-10 10:01:27,657 [salt.state       ][INFO    ][1885] File changed:
New file
2017-12-10 10:01:27,657 [salt.state       ][INFO    ][1885] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 10:01:27.657394 duration_in_ms=100.63
2017-12-10 10:01:27,659 [salt.state       ][INFO    ][1885] Running state [service.systemctl_reload] at time 10:01:27.658950
2017-12-10 10:01:27,659 [salt.state       ][INFO    ][1885] Executing state module.wait for service.systemctl_reload
2017-12-10 10:01:27,660 [salt.state       ][INFO    ][1885] No changes made for service.systemctl_reload
2017-12-10 10:01:27,660 [salt.state       ][INFO    ][1885] Completed state [service.systemctl_reload] at time 10:01:27.660060 duration_in_ms=1.11
2017-12-10 10:01:27,660 [salt.state       ][INFO    ][1885] Running state [service.systemctl_reload] at time 10:01:27.660425
2017-12-10 10:01:27,661 [salt.state       ][INFO    ][1885] Executing state module.mod_watch for service.systemctl_reload
2017-12-10 10:01:27,662 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-10 10:01:27,709 [salt.state       ][INFO    ][1885] {'ret': True}
2017-12-10 10:01:27,709 [salt.state       ][INFO    ][1885] Completed state [service.systemctl_reload] at time 10:01:27.709348 duration_in_ms=48.922
2017-12-10 10:01:27,710 [salt.state       ][INFO    ][1885] Running state [/etc/hostname] at time 10:01:27.709859
2017-12-10 10:01:27,710 [salt.state       ][INFO    ][1885] Executing state file.managed for /etc/hostname
2017-12-10 10:01:27,734 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2017-12-10 10:01:27,737 [salt.state       ][INFO    ][1885] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu-1604
+odl01

2017-12-10 10:01:27,738 [salt.state       ][INFO    ][1885] Completed state [/etc/hostname] at time 10:01:27.738103 duration_in_ms=28.244
2017-12-10 10:01:27,740 [salt.state       ][INFO    ][1885] Running state [hostname odl01] at time 10:01:27.740057
2017-12-10 10:01:27,740 [salt.state       ][INFO    ][1885] Executing state cmd.wait for hostname odl01
2017-12-10 10:01:27,741 [salt.state       ][INFO    ][1885] No changes made for hostname odl01
2017-12-10 10:01:27,741 [salt.state       ][INFO    ][1885] Completed state [hostname odl01] at time 10:01:27.741264 duration_in_ms=1.207
2017-12-10 10:01:27,742 [salt.state       ][INFO    ][1885] Running state [hostname odl01] at time 10:01:27.741588
2017-12-10 10:01:27,742 [salt.state       ][INFO    ][1885] Executing state cmd.mod_watch for hostname odl01
2017-12-10 10:01:27,743 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command 'hostname odl01' in directory '/root'
2017-12-10 10:01:27,751 [salt.state       ][INFO    ][1885] {'pid': 5457, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-10 10:01:27,751 [salt.state       ][INFO    ][1885] Completed state [hostname odl01] at time 10:01:27.751186 duration_in_ms=9.596
2017-12-10 10:01:27,753 [salt.state       ][INFO    ][1885] Running state [mdb02.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.752833
2017-12-10 10:01:27,753 [salt.state       ][INFO    ][1885] Executing state host.present for mdb02.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,755 [salt.state       ][INFO    ][1885] {'host': 'mdb02.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,755 [salt.state       ][INFO    ][1885] Completed state [mdb02.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.755400 duration_in_ms=2.567
2017-12-10 10:01:27,756 [salt.state       ][INFO    ][1885] Running state [mdb02] at time 10:01:27.755768
2017-12-10 10:01:27,756 [salt.state       ][INFO    ][1885] Executing state host.present for mdb02
2017-12-10 10:01:27,757 [salt.state       ][INFO    ][1885] {'host': 'mdb02'}
2017-12-10 10:01:27,757 [salt.state       ][INFO    ][1885] Completed state [mdb02] at time 10:01:27.757219 duration_in_ms=1.451
2017-12-10 10:01:27,758 [salt.state       ][INFO    ][1885] Running state [mdb03.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.757606
2017-12-10 10:01:27,758 [salt.state       ][INFO    ][1885] Executing state host.present for mdb03.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,759 [salt.state       ][INFO    ][1885] {'host': 'mdb03.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,759 [salt.state       ][INFO    ][1885] Completed state [mdb03.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.759000 duration_in_ms=1.394
2017-12-10 10:01:27,759 [salt.state       ][INFO    ][1885] Running state [mdb03] at time 10:01:27.759347
2017-12-10 10:01:27,760 [salt.state       ][INFO    ][1885] Executing state host.present for mdb03
2017-12-10 10:01:27,760 [salt.state       ][INFO    ][1885] {'host': 'mdb03'}
2017-12-10 10:01:27,761 [salt.state       ][INFO    ][1885] Completed state [mdb03] at time 10:01:27.760775 duration_in_ms=1.428
2017-12-10 10:01:27,761 [salt.state       ][INFO    ][1885] Running state [mdb01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.761122
2017-12-10 10:01:27,761 [salt.state       ][INFO    ][1885] Executing state host.present for mdb01.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,762 [salt.state       ][INFO    ][1885] {'host': 'mdb01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,763 [salt.state       ][INFO    ][1885] Completed state [mdb01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.762575 duration_in_ms=1.453
2017-12-10 10:01:27,763 [salt.state       ][INFO    ][1885] Running state [mdb01] at time 10:01:27.762909
2017-12-10 10:01:27,763 [salt.state       ][INFO    ][1885] Executing state host.present for mdb01
2017-12-10 10:01:27,764 [salt.state       ][INFO    ][1885] {'host': 'mdb01'}
2017-12-10 10:01:27,764 [salt.state       ][INFO    ][1885] Completed state [mdb01] at time 10:01:27.764286 duration_in_ms=1.377
2017-12-10 10:01:27,765 [salt.state       ][INFO    ][1885] Running state [mdb] at time 10:01:27.764677
2017-12-10 10:01:27,765 [salt.state       ][INFO    ][1885] Executing state host.present for mdb
2017-12-10 10:01:27,766 [salt.state       ][INFO    ][1885] {'host': 'mdb'}
2017-12-10 10:01:27,766 [salt.state       ][INFO    ][1885] Completed state [mdb] at time 10:01:27.766194 duration_in_ms=1.517
2017-12-10 10:01:27,767 [salt.state       ][INFO    ][1885] Running state [mdb.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.766559
2017-12-10 10:01:27,767 [salt.state       ][INFO    ][1885] Executing state host.present for mdb.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,768 [salt.state       ][INFO    ][1885] {'host': 'mdb.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,768 [salt.state       ][INFO    ][1885] Completed state [mdb.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.768063 duration_in_ms=1.504
2017-12-10 10:01:27,768 [salt.state       ][INFO    ][1885] Running state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.768437
2017-12-10 10:01:27,769 [salt.state       ][INFO    ][1885] Executing state host.present for cfg01.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,770 [salt.state       ][INFO    ][1885] {'host': 'cfg01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,770 [salt.state       ][INFO    ][1885] Completed state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.769994 duration_in_ms=1.557
2017-12-10 10:01:27,770 [salt.state       ][INFO    ][1885] Running state [cfg01] at time 10:01:27.770345
2017-12-10 10:01:27,771 [salt.state       ][INFO    ][1885] Executing state host.present for cfg01
2017-12-10 10:01:27,772 [salt.state       ][INFO    ][1885] {'host': 'cfg01'}
2017-12-10 10:01:27,772 [salt.state       ][INFO    ][1885] Completed state [cfg01] at time 10:01:27.771809 duration_in_ms=1.464
2017-12-10 10:01:27,772 [salt.state       ][INFO    ][1885] Running state [prx01] at time 10:01:27.772176
2017-12-10 10:01:27,773 [salt.state       ][INFO    ][1885] Executing state host.present for prx01
2017-12-10 10:01:27,773 [salt.state       ][INFO    ][1885] {'host': 'prx01'}
2017-12-10 10:01:27,774 [salt.state       ][INFO    ][1885] Completed state [prx01] at time 10:01:27.773785 duration_in_ms=1.609
2017-12-10 10:01:27,774 [salt.state       ][INFO    ][1885] Running state [prx01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.774148
2017-12-10 10:01:27,774 [salt.state       ][INFO    ][1885] Executing state host.present for prx01.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,775 [salt.state       ][INFO    ][1885] {'host': 'prx01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,776 [salt.state       ][INFO    ][1885] Completed state [prx01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.775624 duration_in_ms=1.476
2017-12-10 10:01:27,776 [salt.state       ][INFO    ][1885] Running state [kvm01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.776005
2017-12-10 10:01:27,776 [salt.state       ][INFO    ][1885] Executing state host.present for kvm01.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,777 [salt.state       ][INFO    ][1885] {'host': 'kvm01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,778 [salt.state       ][INFO    ][1885] Completed state [kvm01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.777590 duration_in_ms=1.585
2017-12-10 10:01:27,778 [salt.state       ][INFO    ][1885] Running state [kvm01] at time 10:01:27.777948
2017-12-10 10:01:27,778 [salt.state       ][INFO    ][1885] Executing state host.present for kvm01
2017-12-10 10:01:27,779 [salt.state       ][INFO    ][1885] {'host': 'kvm01'}
2017-12-10 10:01:27,779 [salt.state       ][INFO    ][1885] Completed state [kvm01] at time 10:01:27.779439 duration_in_ms=1.491
2017-12-10 10:01:27,780 [salt.state       ][INFO    ][1885] Running state [kvm03.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.779803
2017-12-10 10:01:27,780 [salt.state       ][INFO    ][1885] Executing state host.present for kvm03.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,781 [salt.state       ][INFO    ][1885] {'host': 'kvm03.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,781 [salt.state       ][INFO    ][1885] Completed state [kvm03.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.781410 duration_in_ms=1.607
2017-12-10 10:01:27,782 [salt.state       ][INFO    ][1885] Running state [kvm03] at time 10:01:27.781763
2017-12-10 10:01:27,782 [salt.state       ][INFO    ][1885] Executing state host.present for kvm03
2017-12-10 10:01:27,783 [salt.state       ][INFO    ][1885] {'host': 'kvm03'}
2017-12-10 10:01:27,783 [salt.state       ][INFO    ][1885] Completed state [kvm03] at time 10:01:27.783256 duration_in_ms=1.493
2017-12-10 10:01:27,784 [salt.state       ][INFO    ][1885] Running state [kvm02.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.783598
2017-12-10 10:01:27,784 [salt.state       ][INFO    ][1885] Executing state host.present for kvm02.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,785 [salt.state       ][INFO    ][1885] {'host': 'kvm02.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,785 [salt.state       ][INFO    ][1885] Completed state [kvm02.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.785151 duration_in_ms=1.553
2017-12-10 10:01:27,786 [salt.state       ][INFO    ][1885] Running state [kvm02] at time 10:01:27.785521
2017-12-10 10:01:27,786 [salt.state       ][INFO    ][1885] Executing state host.present for kvm02
2017-12-10 10:01:27,787 [salt.state       ][INFO    ][1885] {'host': 'kvm02'}
2017-12-10 10:01:27,787 [salt.state       ][INFO    ][1885] Completed state [kvm02] at time 10:01:27.787406 duration_in_ms=1.885
2017-12-10 10:01:27,788 [salt.state       ][INFO    ][1885] Running state [dbs] at time 10:01:27.787769
2017-12-10 10:01:27,788 [salt.state       ][INFO    ][1885] Executing state host.present for dbs
2017-12-10 10:01:27,789 [salt.state       ][INFO    ][1885] {'host': 'dbs'}
2017-12-10 10:01:27,789 [salt.state       ][INFO    ][1885] Completed state [dbs] at time 10:01:27.789395 duration_in_ms=1.626
2017-12-10 10:01:27,790 [salt.state       ][INFO    ][1885] Running state [dbs.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.789756
2017-12-10 10:01:27,790 [salt.state       ][INFO    ][1885] Executing state host.present for dbs.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,791 [salt.state       ][INFO    ][1885] {'host': 'dbs.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,791 [salt.state       ][INFO    ][1885] Completed state [dbs.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.791306 duration_in_ms=1.55
2017-12-10 10:01:27,792 [salt.state       ][INFO    ][1885] Running state [prx.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.791667
2017-12-10 10:01:27,792 [salt.state       ][INFO    ][1885] Executing state host.present for prx.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,793 [salt.state       ][INFO    ][1885] {'host': 'prx.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,793 [salt.state       ][INFO    ][1885] Completed state [prx.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.793272 duration_in_ms=1.605
2017-12-10 10:01:27,794 [salt.state       ][INFO    ][1885] Running state [prx] at time 10:01:27.793660
2017-12-10 10:01:27,794 [salt.state       ][INFO    ][1885] Executing state host.present for prx
2017-12-10 10:01:27,795 [salt.state       ][INFO    ][1885] {'host': 'prx'}
2017-12-10 10:01:27,795 [salt.state       ][INFO    ][1885] Completed state [prx] at time 10:01:27.795191 duration_in_ms=1.531
2017-12-10 10:01:27,796 [salt.state       ][INFO    ][1885] Running state [prx02] at time 10:01:27.795567
2017-12-10 10:01:27,796 [salt.state       ][INFO    ][1885] Executing state host.present for prx02
2017-12-10 10:01:27,797 [salt.state       ][INFO    ][1885] {'host': 'prx02'}
2017-12-10 10:01:27,797 [salt.state       ][INFO    ][1885] Completed state [prx02] at time 10:01:27.797154 duration_in_ms=1.587
2017-12-10 10:01:27,798 [salt.state       ][INFO    ][1885] Running state [prx02.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.797511
2017-12-10 10:01:27,798 [salt.state       ][INFO    ][1885] Executing state host.present for prx02.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,799 [salt.state       ][INFO    ][1885] {'host': 'prx02.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,799 [salt.state       ][INFO    ][1885] Completed state [prx02.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.799077 duration_in_ms=1.566
2017-12-10 10:01:27,799 [salt.state       ][INFO    ][1885] Running state [msg02.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.799438
2017-12-10 10:01:27,800 [salt.state       ][INFO    ][1885] Executing state host.present for msg02.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,801 [salt.state       ][INFO    ][1885] {'host': 'msg02.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,801 [salt.state       ][INFO    ][1885] Completed state [msg02.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.801287 duration_in_ms=1.849
2017-12-10 10:01:27,802 [salt.state       ][INFO    ][1885] Running state [msg02] at time 10:01:27.801661
2017-12-10 10:01:27,802 [salt.state       ][INFO    ][1885] Executing state host.present for msg02
2017-12-10 10:01:27,803 [salt.state       ][INFO    ][1885] {'host': 'msg02'}
2017-12-10 10:01:27,803 [salt.state       ][INFO    ][1885] Completed state [msg02] at time 10:01:27.803193 duration_in_ms=1.533
2017-12-10 10:01:27,804 [salt.state       ][INFO    ][1885] Running state [msg03.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.803570
2017-12-10 10:01:27,804 [salt.state       ][INFO    ][1885] Executing state host.present for msg03.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,805 [salt.state       ][INFO    ][1885] {'host': 'msg03.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,805 [salt.state       ][INFO    ][1885] Completed state [msg03.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.805257 duration_in_ms=1.687
2017-12-10 10:01:27,806 [salt.state       ][INFO    ][1885] Running state [msg03] at time 10:01:27.805620
2017-12-10 10:01:27,806 [salt.state       ][INFO    ][1885] Executing state host.present for msg03
2017-12-10 10:01:27,807 [salt.state       ][INFO    ][1885] {'host': 'msg03'}
2017-12-10 10:01:27,807 [salt.state       ][INFO    ][1885] Completed state [msg03] at time 10:01:27.807230 duration_in_ms=1.61
2017-12-10 10:01:27,808 [salt.state       ][INFO    ][1885] Running state [msg01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.807592
2017-12-10 10:01:27,808 [salt.state       ][INFO    ][1885] Executing state host.present for msg01.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,809 [salt.state       ][INFO    ][1885] {'host': 'msg01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,809 [salt.state       ][INFO    ][1885] Completed state [msg01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.809279 duration_in_ms=1.686
2017-12-10 10:01:27,810 [salt.state       ][INFO    ][1885] Running state [msg01] at time 10:01:27.809655
2017-12-10 10:01:27,810 [salt.state       ][INFO    ][1885] Executing state host.present for msg01
2017-12-10 10:01:27,811 [salt.state       ][INFO    ][1885] {'host': 'msg01'}
2017-12-10 10:01:27,811 [salt.state       ][INFO    ][1885] Completed state [msg01] at time 10:01:27.811242 duration_in_ms=1.587
2017-12-10 10:01:27,812 [salt.state       ][INFO    ][1885] Running state [msg] at time 10:01:27.811589
2017-12-10 10:01:27,812 [salt.state       ][INFO    ][1885] Executing state host.present for msg
2017-12-10 10:01:27,813 [salt.state       ][INFO    ][1885] {'host': 'msg'}
2017-12-10 10:01:27,813 [salt.state       ][INFO    ][1885] Completed state [msg] at time 10:01:27.813219 duration_in_ms=1.63
2017-12-10 10:01:27,814 [salt.state       ][INFO    ][1885] Running state [msg.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.813586
2017-12-10 10:01:27,814 [salt.state       ][INFO    ][1885] Executing state host.present for msg.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,815 [salt.state       ][INFO    ][1885] {'host': 'msg.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,815 [salt.state       ][INFO    ][1885] Completed state [msg.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.815335 duration_in_ms=1.748
2017-12-10 10:01:27,816 [salt.state       ][INFO    ][1885] Running state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.815688
2017-12-10 10:01:27,816 [salt.state       ][INFO    ][1885] Executing state host.present for cfg01.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,817 [salt.state       ][INFO    ][1885] Host cfg01.baremetal-mcp-ocata-odl-ha.local (192.168.10.100) already present
2017-12-10 10:01:27,817 [salt.state       ][INFO    ][1885] Completed state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.816817 duration_in_ms=1.129
2017-12-10 10:01:27,817 [salt.state       ][INFO    ][1885] Running state [cfg01] at time 10:01:27.817174
2017-12-10 10:01:27,818 [salt.state       ][INFO    ][1885] Executing state host.present for cfg01
2017-12-10 10:01:27,818 [salt.state       ][INFO    ][1885] Host cfg01 (192.168.10.100) already present
2017-12-10 10:01:27,818 [salt.state       ][INFO    ][1885] Completed state [cfg01] at time 10:01:27.818290 duration_in_ms=1.116
2017-12-10 10:01:27,819 [salt.state       ][INFO    ][1885] Running state [cmp002] at time 10:01:27.818612
2017-12-10 10:01:27,819 [salt.state       ][INFO    ][1885] Executing state host.present for cmp002
2017-12-10 10:01:27,820 [salt.state       ][INFO    ][1885] {'host': 'cmp002'}
2017-12-10 10:01:27,820 [salt.state       ][INFO    ][1885] Completed state [cmp002] at time 10:01:27.820188 duration_in_ms=1.576
2017-12-10 10:01:27,821 [salt.state       ][INFO    ][1885] Running state [cmp002.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.820558
2017-12-10 10:01:27,821 [salt.state       ][INFO    ][1885] Executing state host.present for cmp002.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,822 [salt.state       ][INFO    ][1885] {'host': 'cmp002.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,822 [salt.state       ][INFO    ][1885] Completed state [cmp002.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.822214 duration_in_ms=1.655
2017-12-10 10:01:27,823 [salt.state       ][INFO    ][1885] Running state [cmp001] at time 10:01:27.822574
2017-12-10 10:01:27,823 [salt.state       ][INFO    ][1885] Executing state host.present for cmp001
2017-12-10 10:01:27,824 [salt.state       ][INFO    ][1885] {'host': 'cmp001'}
2017-12-10 10:01:27,824 [salt.state       ][INFO    ][1885] Completed state [cmp001] at time 10:01:27.824336 duration_in_ms=1.762
2017-12-10 10:01:27,825 [salt.state       ][INFO    ][1885] Running state [cmp001.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.824724
2017-12-10 10:01:27,825 [salt.state       ][INFO    ][1885] Executing state host.present for cmp001.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,826 [salt.state       ][INFO    ][1885] {'host': 'cmp001.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,827 [salt.state       ][INFO    ][1885] Completed state [cmp001.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.826471 duration_in_ms=1.747
2017-12-10 10:01:27,827 [salt.state       ][INFO    ][1885] Running state [dbs01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.826810
2017-12-10 10:01:27,827 [salt.state       ][INFO    ][1885] Executing state host.present for dbs01.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,828 [salt.state       ][INFO    ][1885] {'host': 'dbs01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,828 [salt.state       ][INFO    ][1885] Completed state [dbs01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.828391 duration_in_ms=1.581
2017-12-10 10:01:27,829 [salt.state       ][INFO    ][1885] Running state [dbs01] at time 10:01:27.828837
2017-12-10 10:01:27,829 [salt.state       ][INFO    ][1885] Executing state host.present for dbs01
2017-12-10 10:01:27,830 [salt.state       ][INFO    ][1885] {'host': 'dbs01'}
2017-12-10 10:01:27,831 [salt.state       ][INFO    ][1885] Completed state [dbs01] at time 10:01:27.830522 duration_in_ms=1.685
2017-12-10 10:01:27,831 [salt.state       ][INFO    ][1885] Running state [dbs02.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.830860
2017-12-10 10:01:27,831 [salt.state       ][INFO    ][1885] Executing state host.present for dbs02.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,832 [salt.state       ][INFO    ][1885] {'host': 'dbs02.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,832 [salt.state       ][INFO    ][1885] Completed state [dbs02.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.832440 duration_in_ms=1.58
2017-12-10 10:01:27,833 [salt.state       ][INFO    ][1885] Running state [dbs02] at time 10:01:27.832820
2017-12-10 10:01:27,833 [salt.state       ][INFO    ][1885] Executing state host.present for dbs02
2017-12-10 10:01:27,834 [salt.state       ][INFO    ][1885] {'host': 'dbs02'}
2017-12-10 10:01:27,835 [salt.state       ][INFO    ][1885] Completed state [dbs02] at time 10:01:27.834558 duration_in_ms=1.738
2017-12-10 10:01:27,835 [salt.state       ][INFO    ][1885] Running state [dbs03.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.834926
2017-12-10 10:01:27,835 [salt.state       ][INFO    ][1885] Executing state host.present for dbs03.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,837 [salt.state       ][INFO    ][1885] {'host': 'dbs03.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,837 [salt.state       ][INFO    ][1885] Completed state [dbs03.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.836909 duration_in_ms=1.983
2017-12-10 10:01:27,837 [salt.state       ][INFO    ][1885] Running state [dbs03] at time 10:01:27.837303
2017-12-10 10:01:27,838 [salt.state       ][INFO    ][1885] Executing state host.present for dbs03
2017-12-10 10:01:27,839 [salt.state       ][INFO    ][1885] {'host': 'dbs03'}
2017-12-10 10:01:27,839 [salt.state       ][INFO    ][1885] Completed state [dbs03] at time 10:01:27.838985 duration_in_ms=1.681
2017-12-10 10:01:27,839 [salt.state       ][INFO    ][1885] Running state [odl01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.839342
2017-12-10 10:01:27,840 [salt.state       ][INFO    ][1885] Executing state host.present for odl01.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,841 [salt.state       ][INFO    ][1885] {'host': 'odl01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,841 [salt.state       ][INFO    ][1885] Completed state [odl01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.841075 duration_in_ms=1.733
2017-12-10 10:01:27,841 [salt.state       ][INFO    ][1885] Running state [odl01] at time 10:01:27.841445
2017-12-10 10:01:27,842 [salt.state       ][INFO    ][1885] Executing state host.present for odl01
2017-12-10 10:01:27,843 [salt.state       ][INFO    ][1885] {'host': 'odl01'}
2017-12-10 10:01:27,843 [salt.state       ][INFO    ][1885] Completed state [odl01] at time 10:01:27.843263 duration_in_ms=1.817
2017-12-10 10:01:27,844 [salt.state       ][INFO    ][1885] Running state [mas01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.843628
2017-12-10 10:01:27,844 [salt.state       ][INFO    ][1885] Executing state host.present for mas01.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,845 [salt.state       ][INFO    ][1885] {'host': 'mas01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,845 [salt.state       ][INFO    ][1885] Completed state [mas01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.845402 duration_in_ms=1.773
2017-12-10 10:01:27,846 [salt.state       ][INFO    ][1885] Running state [mas01] at time 10:01:27.845777
2017-12-10 10:01:27,846 [salt.state       ][INFO    ][1885] Executing state host.present for mas01
2017-12-10 10:01:27,847 [salt.state       ][INFO    ][1885] {'host': 'mas01'}
2017-12-10 10:01:27,847 [salt.state       ][INFO    ][1885] Completed state [mas01] at time 10:01:27.847428 duration_in_ms=1.651
2017-12-10 10:01:27,848 [salt.state       ][INFO    ][1885] Running state [ctl02.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.847772
2017-12-10 10:01:27,848 [salt.state       ][INFO    ][1885] Executing state host.present for ctl02.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,849 [salt.state       ][INFO    ][1885] {'host': 'ctl02.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,850 [salt.state       ][INFO    ][1885] Completed state [ctl02.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.849618 duration_in_ms=1.846
2017-12-10 10:01:27,850 [salt.state       ][INFO    ][1885] Running state [ctl02] at time 10:01:27.849986
2017-12-10 10:01:27,850 [salt.state       ][INFO    ][1885] Executing state host.present for ctl02
2017-12-10 10:01:27,851 [salt.state       ][INFO    ][1885] {'host': 'ctl02'}
2017-12-10 10:01:27,852 [salt.state       ][INFO    ][1885] Completed state [ctl02] at time 10:01:27.851661 duration_in_ms=1.674
2017-12-10 10:01:27,852 [salt.state       ][INFO    ][1885] Running state [ctl03.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.852004
2017-12-10 10:01:27,852 [salt.state       ][INFO    ][1885] Executing state host.present for ctl03.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,853 [salt.state       ][INFO    ][1885] {'host': 'ctl03.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,854 [salt.state       ][INFO    ][1885] Completed state [ctl03.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.853747 duration_in_ms=1.743
2017-12-10 10:01:27,854 [salt.state       ][INFO    ][1885] Running state [ctl03] at time 10:01:27.854092
2017-12-10 10:01:27,854 [salt.state       ][INFO    ][1885] Executing state host.present for ctl03
2017-12-10 10:01:27,856 [salt.state       ][INFO    ][1885] {'host': 'ctl03'}
2017-12-10 10:01:27,856 [salt.state       ][INFO    ][1885] Completed state [ctl03] at time 10:01:27.855870 duration_in_ms=1.779
2017-12-10 10:01:27,856 [salt.state       ][INFO    ][1885] Running state [ctl01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.856211
2017-12-10 10:01:27,857 [salt.state       ][INFO    ][1885] Executing state host.present for ctl01.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,858 [salt.state       ][INFO    ][1885] {'host': 'ctl01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,858 [salt.state       ][INFO    ][1885] Completed state [ctl01.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.858106 duration_in_ms=1.895
2017-12-10 10:01:27,858 [salt.state       ][INFO    ][1885] Running state [ctl01] at time 10:01:27.858451
2017-12-10 10:01:27,859 [salt.state       ][INFO    ][1885] Executing state host.present for ctl01
2017-12-10 10:01:27,860 [salt.state       ][INFO    ][1885] {'host': 'ctl01'}
2017-12-10 10:01:27,860 [salt.state       ][INFO    ][1885] Completed state [ctl01] at time 10:01:27.860208 duration_in_ms=1.757
2017-12-10 10:01:27,861 [salt.state       ][INFO    ][1885] Running state [ctl] at time 10:01:27.860619
2017-12-10 10:01:27,861 [salt.state       ][INFO    ][1885] Executing state host.present for ctl
2017-12-10 10:01:27,862 [salt.state       ][INFO    ][1885] {'host': 'ctl'}
2017-12-10 10:01:27,863 [salt.state       ][INFO    ][1885] Completed state [ctl] at time 10:01:27.862489 duration_in_ms=1.87
2017-12-10 10:01:27,863 [salt.state       ][INFO    ][1885] Running state [ctl.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.862836
2017-12-10 10:01:27,863 [salt.state       ][INFO    ][1885] Executing state host.present for ctl.baremetal-mcp-ocata-odl-ha.local
2017-12-10 10:01:27,864 [salt.state       ][INFO    ][1885] {'host': 'ctl.baremetal-mcp-ocata-odl-ha.local'}
2017-12-10 10:01:27,865 [salt.state       ][INFO    ][1885] Completed state [ctl.baremetal-mcp-ocata-odl-ha.local] at time 10:01:27.864650 duration_in_ms=1.813
2017-12-10 10:01:27,868 [salt.state       ][INFO    ][1885] Running state [ens3] at time 10:01:27.867988
2017-12-10 10:01:27,868 [salt.state       ][INFO    ][1885] Executing state network.managed for ens3
2017-12-10 10:01:27,967 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['ifdown', 'ens3'] in directory '/root'
2017-12-10 10:01:27,989 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['ifup', 'ens3'] in directory '/root'
2017-12-10 10:01:28,063 [salt.state       ][INFO    ][1885] {'interface': u'--- \n+++ \n@@ -1,3 +1,5 @@\n auto ens3\n\n-iface ens3 inet dhcp\n\n+iface ens3 inet static\n\n+    address 192.168.10.111\n\n+    netmask 255.255.255.0\n\n \n', 'status': 'Interface ens3 restart to validate'}
2017-12-10 10:01:28,064 [salt.state       ][INFO    ][1885] Completed state [ens3] at time 10:01:28.063483 duration_in_ms=195.494
2017-12-10 10:01:28,064 [salt.state       ][INFO    ][1885] Running state [/etc/profile.d/proxy.sh] at time 10:01:28.063933
2017-12-10 10:01:28,064 [salt.state       ][INFO    ][1885] Executing state file.absent for /etc/profile.d/proxy.sh
2017-12-10 10:01:28,065 [salt.state       ][INFO    ][1885] File /etc/profile.d/proxy.sh is not present
2017-12-10 10:01:28,065 [salt.state       ][INFO    ][1885] Completed state [/etc/profile.d/proxy.sh] at time 10:01:28.065237 duration_in_ms=1.304
2017-12-10 10:01:28,066 [salt.state       ][INFO    ][1885] Running state [/etc/apt/apt.conf.d/95proxies] at time 10:01:28.065599
2017-12-10 10:01:28,066 [salt.state       ][INFO    ][1885] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2017-12-10 10:01:28,066 [salt.state       ][INFO    ][1885] File /etc/apt/apt.conf.d/95proxies is not present
2017-12-10 10:01:28,067 [salt.state       ][INFO    ][1885] Completed state [/etc/apt/apt.conf.d/95proxies] at time 10:01:28.066647 duration_in_ms=1.048
2017-12-10 10:01:28,073 [salt.state       ][INFO    ][1885] Running state [ntp] at time 10:01:28.072913
2017-12-10 10:01:28,073 [salt.state       ][INFO    ][1885] Executing state pkg.installed for ntp
2017-12-10 10:01:28,247 [salt.loaded.int.module.cmdmod][INFO    ][1885] 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-12-10 10:01:30,547 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:01:30,572 [salt.state       ][INFO    ][1885] Made the following changes:
'ntp' changed from 'absent' to '1:4.2.8p4+dfsg-3ubuntu5.7'
'libopts25' changed from 'absent' to '1:5.18.7-3'

2017-12-10 10:01:30,584 [salt.state       ][INFO    ][1885] Loading fresh modules for state activity
2017-12-10 10:01:30,602 [salt.state       ][INFO    ][1885] Completed state [ntp] at time 10:01:30.601978 duration_in_ms=2529.065
2017-12-10 10:01:30,605 [salt.state       ][INFO    ][1885] Running state [/etc/ntp.conf] at time 10:01:30.604785
2017-12-10 10:01:30,605 [salt.state       ][INFO    ][1885] Executing state file.managed for /etc/ntp.conf
2017-12-10 10:01:30,626 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2017-12-10 10:01:30,652 [salt.fileclient  ][INFO    ][1885] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-10 10:01:30,664 [salt.state       ][INFO    ][1885] 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-12-10 10:01:30,666 [salt.state       ][INFO    ][1885] Completed state [/etc/ntp.conf] at time 10:01:30.666074 duration_in_ms=61.288
2017-12-10 10:01:30,741 [salt.state       ][INFO    ][1885] Running state [ntp] at time 10:01:30.740556
2017-12-10 10:01:30,741 [salt.state       ][INFO    ][1885] Executing state service.running for ntp
2017-12-10 10:01:30,743 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2017-12-10 10:01:30,752 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2017-12-10 10:01:30,761 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2017-12-10 10:01:30,772 [salt.state       ][INFO    ][1885] The service ntp is already running
2017-12-10 10:01:30,773 [salt.state       ][INFO    ][1885] Completed state [ntp] at time 10:01:30.772667 duration_in_ms=32.109
2017-12-10 10:01:30,773 [salt.state       ][INFO    ][1885] Running state [ntp] at time 10:01:30.773073
2017-12-10 10:01:30,774 [salt.state       ][INFO    ][1885] Executing state service.mod_watch for ntp
2017-12-10 10:01:30,774 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2017-12-10 10:01:30,785 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2017-12-10 10:01:30,796 [salt.loaded.int.module.cmdmod][INFO    ][1885] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2017-12-10 10:01:30,862 [salt.state       ][INFO    ][1885] {'ntp': True}
2017-12-10 10:01:30,862 [salt.state       ][INFO    ][1885] Completed state [ntp] at time 10:01:30.862237 duration_in_ms=89.163
2017-12-10 10:01:30,866 [salt.minion      ][INFO    ][1885] Returning information for job: 20171210100053850138
2017-12-10 10:01:53,595 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20171210100153580046
2017-12-10 10:01:53,609 [salt.minion      ][INFO    ][5804] Starting a new job with PID 5804
2017-12-10 10:01:53,621 [salt.minion      ][INFO    ][5804] Returning information for job: 20171210100153580046
2017-12-10 10:07:07,235 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command state.sls with jid 20171210100707221240
2017-12-10 10:07:07,246 [salt.minion      ][INFO    ][6024] Starting a new job with PID 6024
2017-12-10 10:07:09,453 [salt.state       ][INFO    ][6024] Loading fresh modules for state activity
2017-12-10 10:07:09,499 [salt.fileclient  ][INFO    ][6024] Fetching file from saltenv 'base', ** done ** 'opendaylight/init.sls'
2017-12-10 10:07:09,563 [salt.fileclient  ][INFO    ][6024] Fetching file from saltenv 'base', ** done ** 'opendaylight/server.sls'
2017-12-10 10:07:09,593 [salt.fileclient  ][INFO    ][6024] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
2017-12-10 10:07:09,622 [salt.state       ][INFO    ][6024] Running state [opendaylight_repo] at time 10:07:09.622206
2017-12-10 10:07:09,623 [salt.state       ][INFO    ][6024] Executing state pkgrepo.managed for opendaylight_repo
2017-12-10 10:07:09,693 [salt.loaded.int.module.cmdmod][INFO    ][6024] Executing command ['apt-add-repository', '-y', 'ppa:odl-team/nitrogen'] in directory '/root'
2017-12-10 10:07:10,542 [salt.loaded.int.module.cmdmod][INFO    ][6024] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-10 10:07:12,581 [salt.state       ][INFO    ][6024] {'repo': 'ppa:odl-team/nitrogen'}
2017-12-10 10:07:12,582 [salt.state       ][INFO    ][6024] Completed state [opendaylight_repo] at time 10:07:12.581993 duration_in_ms=2959.787
2017-12-10 10:07:12,822 [salt.state       ][INFO    ][6024] Running state [opendaylight] at time 10:07:12.822439
2017-12-10 10:07:12,823 [salt.state       ][INFO    ][6024] Executing state pkg.installed for opendaylight
2017-12-10 10:07:12,824 [salt.loaded.int.module.cmdmod][INFO    ][6024] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:07:13,286 [salt.loaded.int.module.cmdmod][INFO    ][6024] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-10 10:07:15,293 [salt.loaded.int.module.cmdmod][INFO    ][6024] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'opendaylight'] in directory '/root'
2017-12-10 10:07:17,346 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100717327554
2017-12-10 10:07:17,357 [salt.minion      ][INFO    ][6919] Starting a new job with PID 6919
2017-12-10 10:07:17,366 [salt.minion      ][INFO    ][6919] Returning information for job: 20171210100717327554
2017-12-10 10:07:27,563 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100727540372
2017-12-10 10:07:27,572 [salt.minion      ][INFO    ][6929] Starting a new job with PID 6929
2017-12-10 10:07:27,581 [salt.minion      ][INFO    ][6929] Returning information for job: 20171210100727540372
2017-12-10 10:07:37,774 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100737755001
2017-12-10 10:07:37,783 [salt.minion      ][INFO    ][6934] Starting a new job with PID 6934
2017-12-10 10:07:37,791 [salt.minion      ][INFO    ][6934] Returning information for job: 20171210100737755001
2017-12-10 10:07:47,984 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100747963808
2017-12-10 10:07:47,994 [salt.minion      ][INFO    ][7027] Starting a new job with PID 7027
2017-12-10 10:07:48,004 [salt.minion      ][INFO    ][7027] Returning information for job: 20171210100747963808
2017-12-10 10:07:58,199 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100758183162
2017-12-10 10:07:58,209 [salt.minion      ][INFO    ][7032] Starting a new job with PID 7032
2017-12-10 10:07:58,218 [salt.minion      ][INFO    ][7032] Returning information for job: 20171210100758183162
2017-12-10 10:08:08,409 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100808391609
2017-12-10 10:08:08,419 [salt.minion      ][INFO    ][7108] Starting a new job with PID 7108
2017-12-10 10:08:08,428 [salt.minion      ][INFO    ][7108] Returning information for job: 20171210100808391609
2017-12-10 10:08:18,620 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100818601418
2017-12-10 10:08:18,632 [salt.minion      ][INFO    ][7113] Starting a new job with PID 7113
2017-12-10 10:08:18,642 [salt.minion      ][INFO    ][7113] Returning information for job: 20171210100818601418
2017-12-10 10:08:28,683 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100828663385
2017-12-10 10:08:28,694 [salt.minion      ][INFO    ][7118] Starting a new job with PID 7118
2017-12-10 10:08:28,704 [salt.minion      ][INFO    ][7118] Returning information for job: 20171210100828663385
2017-12-10 10:08:38,907 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100838883429
2017-12-10 10:08:38,918 [salt.minion      ][INFO    ][7128] Starting a new job with PID 7128
2017-12-10 10:08:38,927 [salt.minion      ][INFO    ][7128] Returning information for job: 20171210100838883429
2017-12-10 10:08:49,130 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100849111397
2017-12-10 10:08:49,141 [salt.minion      ][INFO    ][7133] Starting a new job with PID 7133
2017-12-10 10:08:49,150 [salt.minion      ][INFO    ][7133] Returning information for job: 20171210100849111397
2017-12-10 10:08:59,353 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100859333401
2017-12-10 10:08:59,364 [salt.minion      ][INFO    ][7143] Starting a new job with PID 7143
2017-12-10 10:08:59,372 [salt.minion      ][INFO    ][7143] Returning information for job: 20171210100859333401
2017-12-10 10:09:09,579 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100909554724
2017-12-10 10:09:09,590 [salt.minion      ][INFO    ][7148] Starting a new job with PID 7148
2017-12-10 10:09:09,599 [salt.minion      ][INFO    ][7148] Returning information for job: 20171210100909554724
2017-12-10 10:09:19,803 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100919785300
2017-12-10 10:09:19,813 [salt.minion      ][INFO    ][7153] Starting a new job with PID 7153
2017-12-10 10:09:19,822 [salt.minion      ][INFO    ][7153] Returning information for job: 20171210100919785300
2017-12-10 10:09:30,034 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100930012264
2017-12-10 10:09:30,046 [salt.minion      ][INFO    ][7163] Starting a new job with PID 7163
2017-12-10 10:09:30,055 [salt.minion      ][INFO    ][7163] Returning information for job: 20171210100930012264
2017-12-10 10:09:40,265 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100940247738
2017-12-10 10:09:40,276 [salt.minion      ][INFO    ][7169] Starting a new job with PID 7169
2017-12-10 10:09:40,285 [salt.minion      ][INFO    ][7169] Returning information for job: 20171210100940247738
2017-12-10 10:09:50,498 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210100950477036
2017-12-10 10:09:50,509 [salt.minion      ][INFO    ][7175] Starting a new job with PID 7175
2017-12-10 10:09:50,518 [salt.minion      ][INFO    ][7175] Returning information for job: 20171210100950477036
2017-12-10 10:10:00,530 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101000510518
2017-12-10 10:10:00,540 [salt.minion      ][INFO    ][7185] Starting a new job with PID 7185
2017-12-10 10:10:00,549 [salt.minion      ][INFO    ][7185] Returning information for job: 20171210101000510518
2017-12-10 10:10:10,557 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101010536003
2017-12-10 10:10:10,568 [salt.minion      ][INFO    ][7190] Starting a new job with PID 7190
2017-12-10 10:10:10,577 [salt.minion      ][INFO    ][7190] Returning information for job: 20171210101010536003
2017-12-10 10:10:20,794 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101020770352
2017-12-10 10:10:20,805 [salt.minion      ][INFO    ][7195] Starting a new job with PID 7195
2017-12-10 10:10:20,816 [salt.minion      ][INFO    ][7195] Returning information for job: 20171210101020770352
2017-12-10 10:10:30,831 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101030810467
2017-12-10 10:10:30,842 [salt.minion      ][INFO    ][7205] Starting a new job with PID 7205
2017-12-10 10:10:30,852 [salt.minion      ][INFO    ][7205] Returning information for job: 20171210101030810467
2017-12-10 10:10:40,862 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101040845341
2017-12-10 10:10:40,874 [salt.minion      ][INFO    ][7210] Starting a new job with PID 7210
2017-12-10 10:10:40,884 [salt.minion      ][INFO    ][7210] Returning information for job: 20171210101040845341
2017-12-10 10:10:51,047 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101051023820
2017-12-10 10:10:51,057 [salt.minion      ][INFO    ][7215] Starting a new job with PID 7215
2017-12-10 10:10:51,067 [salt.minion      ][INFO    ][7215] Returning information for job: 20171210101051023820
2017-12-10 10:11:01,087 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101101061173
2017-12-10 10:11:01,098 [salt.minion      ][INFO    ][7225] Starting a new job with PID 7225
2017-12-10 10:11:01,109 [salt.minion      ][INFO    ][7225] Returning information for job: 20171210101101061173
2017-12-10 10:11:11,147 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101111123768
2017-12-10 10:11:11,158 [salt.minion      ][INFO    ][7230] Starting a new job with PID 7230
2017-12-10 10:11:11,168 [salt.minion      ][INFO    ][7230] Returning information for job: 20171210101111123768
2017-12-10 10:11:21,193 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101121175323
2017-12-10 10:11:21,203 [salt.minion      ][INFO    ][7240] Starting a new job with PID 7240
2017-12-10 10:11:21,214 [salt.minion      ][INFO    ][7240] Returning information for job: 20171210101121175323
2017-12-10 10:11:31,252 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101131231361
2017-12-10 10:11:31,261 [salt.minion      ][INFO    ][7245] Starting a new job with PID 7245
2017-12-10 10:11:31,271 [salt.minion      ][INFO    ][7245] Returning information for job: 20171210101131231361
2017-12-10 10:11:41,305 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101141287733
2017-12-10 10:11:41,316 [salt.minion      ][INFO    ][7255] Starting a new job with PID 7255
2017-12-10 10:11:41,326 [salt.minion      ][INFO    ][7255] Returning information for job: 20171210101141287733
2017-12-10 10:11:51,376 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101151356281
2017-12-10 10:11:51,387 [salt.minion      ][INFO    ][7260] Starting a new job with PID 7260
2017-12-10 10:11:51,397 [salt.minion      ][INFO    ][7260] Returning information for job: 20171210101151356281
2017-12-10 10:12:01,451 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101201428221
2017-12-10 10:12:01,461 [salt.minion      ][INFO    ][7265] Starting a new job with PID 7265
2017-12-10 10:12:01,471 [salt.minion      ][INFO    ][7265] Returning information for job: 20171210101201428221
2017-12-10 10:12:11,523 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101211504550
2017-12-10 10:12:11,532 [salt.minion      ][INFO    ][7275] Starting a new job with PID 7275
2017-12-10 10:12:11,542 [salt.minion      ][INFO    ][7275] Returning information for job: 20171210101211504550
2017-12-10 10:12:21,591 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101221573248
2017-12-10 10:12:21,603 [salt.minion      ][INFO    ][7280] Starting a new job with PID 7280
2017-12-10 10:12:21,614 [salt.minion      ][INFO    ][7280] Returning information for job: 20171210101221573248
2017-12-10 10:12:31,680 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101231660407
2017-12-10 10:12:31,691 [salt.minion      ][INFO    ][7368] Starting a new job with PID 7368
2017-12-10 10:12:31,701 [salt.minion      ][INFO    ][7368] Returning information for job: 20171210101231660407
2017-12-10 10:12:41,758 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101241738197
2017-12-10 10:12:41,768 [salt.minion      ][INFO    ][7660] Starting a new job with PID 7660
2017-12-10 10:12:41,779 [salt.minion      ][INFO    ][7660] Returning information for job: 20171210101241738197
2017-12-10 10:12:51,893 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101251870566
2017-12-10 10:12:51,905 [salt.minion      ][INFO    ][7665] Starting a new job with PID 7665
2017-12-10 10:12:51,915 [salt.minion      ][INFO    ][7665] Returning information for job: 20171210101251870566
2017-12-10 10:13:02,015 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command saltutil.find_job with jid 20171210101301985714
2017-12-10 10:13:02,028 [salt.minion      ][INFO    ][10325] Starting a new job with PID 10325
2017-12-10 10:13:02,041 [salt.minion      ][INFO    ][10325] Returning information for job: 20171210101301985714
2017-12-10 10:13:02,146 [salt.loaded.int.module.cmdmod][INFO    ][6024] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-10 10:13:02,171 [salt.state       ][INFO    ][6024] Made the following changes:
'java-common' changed from 'absent' to '0.56ubuntu2'
'libxtst6' changed from 'absent' to '2:1.2.2-1'
'liblcms2-2' changed from 'absent' to '2.6-3ubuntu2'
'openjdk-8-jre-headless' changed from 'absent' to '8u151-b12-0ubuntu0.16.04.2'
'libxrender1' changed from 'absent' to '1:0.9.9-0ubuntu1'
'libavahi-common3' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2'
'libnspr4' changed from 'absent' to '2:4.13.1-0ubuntu0.16.04.1'
'libfontconfig' changed from 'absent' to '1'
'fonts-dejavu-core' changed from 'absent' to '2.35-1'
'libnss3-nssdb' changed from 'absent' to '2:3.28.4-0ubuntu0.16.04.3'
'java8-runtime-headless' changed from 'absent' to '1'
'libcups2' changed from 'absent' to '2.1.3-4ubuntu0.3'
'libjpeg-turbo8' changed from 'absent' to '1.4.2-0ubuntu3'
'libavahi-client3' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2'
'libnss3' changed from 'absent' to '2:3.28.4-0ubuntu0.16.04.3'
'libpcsclite1' changed from 'absent' to '1.8.14-1ubuntu1.16.04.1'
'java7-runtime-headless' changed from 'absent' to '1'
'ca-certificates-java' changed from 'absent' to '20160321'
'java2-runtime-headless' changed from 'absent' to '1'
'fontconfig-config' changed from 'absent' to '2.11.94-0ubuntu1.1'
'libavahi-common-data' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2'
'libxi6' changed from 'absent' to '2:1.7.6-1'
'java5-runtime-headless' changed from 'absent' to '1'
'java6-runtime-headless' changed from 'absent' to '1'
'x11-common' changed from 'absent' to '1:7.7+13ubuntu3'
'libjpeg8' changed from 'absent' to '8c-2ubuntu8'
'opendaylight' changed from 'absent' to '7.0.0-1ppa2'
'libfontconfig1' changed from 'absent' to '2.11.94-0ubuntu1.1'

2017-12-10 10:13:02,185 [salt.state       ][INFO    ][6024] Loading fresh modules for state activity
2017-12-10 10:13:02,206 [salt.state       ][INFO    ][6024] Completed state [opendaylight] at time 10:13:02.205673 duration_in_ms=349383.235
2017-12-10 10:13:02,333 [salt.state       ][INFO    ][6024] Running state [/opt/opendaylight/etc/jetty.xml] at time 10:13:02.333309
2017-12-10 10:13:02,334 [salt.state       ][INFO    ][6024] Executing state file.managed for /opt/opendaylight/etc/jetty.xml
2017-12-10 10:13:02,377 [salt.fileclient  ][INFO    ][6024] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/jetty.xml'
2017-12-10 10:13:02,410 [salt.fileclient  ][INFO    ][6024] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
2017-12-10 10:13:02,431 [salt.state       ][INFO    ][6024] File changed:
--- 
+++ 
@@ -79,7 +79,7 @@
                         </Item>
                     </Array>
                 </Arg>
-                <Set name="host">
+                <Set name="host">192.168.10.111
                     <Property name="jetty.host"/>
                 </Set>
                 <Set name="port">
@@ -110,11 +110,11 @@
                         </Item>
                     </Array>
                 </Arg>
-                <Set name="host">
+                <Set name="host">192.168.10.111
                     <Property name="jetty.host"/>
                 </Set>
                 <Set name="port">
-                    <Property name="jetty.port" default="8080"/>
+                    <Property name="jetty.port" default="8282"/>
                 </Set>
                 <Set name="idleTimeout">
                     <Property name="http.timeout" default="300000"/>

2017-12-10 10:13:02,434 [salt.state       ][INFO    ][6024] Completed state [/opt/opendaylight/etc/jetty.xml] at time 10:13:02.433602 duration_in_ms=100.294
2017-12-10 10:13:02,434 [salt.state       ][INFO    ][6024] Running state [/opt/opendaylight/bin/setenv] at time 10:13:02.434034
2017-12-10 10:13:02,434 [salt.state       ][INFO    ][6024] Executing state file.managed for /opt/opendaylight/bin/setenv
2017-12-10 10:13:02,468 [salt.fileclient  ][INFO    ][6024] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/setenv.shell'
2017-12-10 10:13:02,498 [salt.fileclient  ][INFO    ][6024] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
2017-12-10 10:13:02,506 [salt.state       ][INFO    ][6024] File changed:
--- 
+++ 
@@ -1,46 +1,15 @@
-#!/bin/sh
-#
-#    Licensed to the Apache Software Foundation (ASF) under one or more
-#    contributor license agreements.  See the NOTICE file distributed with
-#    this work for additional information regarding copyright ownership.
-#    The ASF licenses this file to You under the Apache License, Version 2.0
-#    (the "License"); you may not use this file except in compliance with
-#    the License.  You may obtain a copy of the License at
-#
-#       http://www.apache.org/licenses/LICENSE-2.0
-#
-#    Unless required by applicable law or agreed to in writing, software
-#    distributed under the License is distributed on an "AS IS" BASIS,
-#    WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
-#    See the License for the specific language governing permissions and
-#    limitations under the License.
-#
-
-#
-# handle specific scripts; the SCRIPT_NAME is exactly the name of the Karaf
-# script: client, instance, shell, start, status, stop, karaf
-#
-# if [ "$KARAF_SCRIPT" == "SCRIPT_NAME" ]; then
-#   Actions go here...
-# fi
-
-#
-# general settings which should be applied for all scripts go here; please keep
-# in mind that it is possible that scripts might be executed more than once, e.g.
-# in example of the start script where the start script is executed first and the
-# karaf script afterwards.
-#
-
-#
-# The following section shows the possible configuration options for the default 
-# karaf scripts
-#
-# export JAVA_HOME # Location of Java installation
-# export JAVA_MIN_MEM # Minimum memory for the JVM
-# export JAVA_MAX_MEM # Maximum memory for the JVM
+##############################################################################
+# Copyright (c) 2017 Mirantis Inc. and others.
+# All rights reserved. This program and the accompanying materials
+# are made available under the terms of the Apache License, Version 2.0
+# which accompanies this distribution, and is available at
+# http://www.apache.org/licenses/LICENSE-2.0
+############################################################################### export JAVA_HOME # Location of Java installation
+export JAVA_MIN_MEM=4g # Minimum memory for the JVM
+export JAVA_MAX_MEM=4g # Maximum memory for the JVM
 # export JAVA_PERM_MEM # Minimum perm memory for the JVM
-# export JAVA_MAX_PERM_MEM # Maximum perm memory for the JVM
-# export EXTRA_JAVA_OPTS # Additional JVM options
+export JAVA_MAX_PERM_MEM=512m # Maximum perm memory for the JVM
+export EXTRA_JAVA_OPTS='-Djava.net.preferIPv4Stack=true -XX:+UseG1GC' # Additional JVM options
 # export KARAF_HOME # Karaf home folder
 # export KARAF_DATA # Karaf data folder
 # export KARAF_BASE # Karaf base folder
@@ -48,7 +17,4 @@
 # export KARAF_OPTS # Additional available Karaf options
 # export KARAF_DEBUG # Enable debug mode
 # export KARAF_REDIRECT # Enable/set the std/err redirection when using bin/start
-# export KARAF_NOROOT # Prevent execution as root if set to true
-if [ "x$JAVA_MAX_MEM" = "x" ]; then
-    export JAVA_MAX_MEM="2048m"
-fi
+

2017-12-10 10:13:02,509 [salt.state       ][INFO    ][6024] Completed state [/opt/opendaylight/bin/setenv] at time 10:13:02.508706 duration_in_ms=74.671
2017-12-10 10:13:02,514 [salt.state       ][INFO    ][6024] Running state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 10:13:02.514349
2017-12-10 10:13:02,515 [salt.state       ][INFO    ][6024] Executing state ini.options_present for /opt/opendaylight/etc/org.apache.karaf.features.cfg
2017-12-10 10:13:02,532 [salt.state       ][INFO    ][6024] {'featuresBoot': {'after': 'standard,wrap,ssh,odl-restconf-all,odl-aaa-authn,odl-dlux-all,odl-mdsal-apidocs,odl-netvirt-openstack', 'before': '\\\n    standard, \\\n    wrap'}}
2017-12-10 10:13:02,533 [salt.state       ][INFO    ][6024] Completed state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 10:13:02.532480 duration_in_ms=18.131
2017-12-10 10:13:02,533 [salt.state       ][INFO    ][6024] Running state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 10:13:02.532780
2017-12-10 10:13:02,533 [salt.state       ][INFO    ][6024] Executing state ini.options_present for /opt/opendaylight/etc/org.ops4j.pax.web.cfg
2017-12-10 10:13:02,534 [salt.state       ][INFO    ][6024] {'org.ops4j.pax.web.listening.addresses': {'after': '192.168.10.111', 'before': None}}
2017-12-10 10:13:02,534 [salt.state       ][INFO    ][6024] Completed state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 10:13:02.533691 duration_in_ms=0.911
2017-12-10 10:13:02,534 [salt.state       ][INFO    ][6024] Running state [/opt/opendaylight/etc/custom.properties] at time 10:13:02.533985
2017-12-10 10:13:02,534 [salt.state       ][INFO    ][6024] Executing state ini.options_present for /opt/opendaylight/etc/custom.properties
2017-12-10 10:13:02,562 [salt.state       ][INFO    ][6024] {'ovsdb.l3.fwd.enabled': {'after': 'yes', 'before': None}, 'ovsdb.of.version': {'after': 1.3, 'before': None}}
2017-12-10 10:13:02,563 [salt.state       ][INFO    ][6024] Completed state [/opt/opendaylight/etc/custom.properties] at time 10:13:02.562478 duration_in_ms=28.493
2017-12-10 10:13:02,563 [salt.state       ][INFO    ][6024] Running state [opendaylight] at time 10:13:02.562920
2017-12-10 10:13:02,563 [salt.state       ][INFO    ][6024] Executing state service.running for opendaylight
2017-12-10 10:13:02,565 [salt.loaded.int.module.cmdmod][INFO    ][6024] Executing command ['systemctl', 'status', 'opendaylight.service', '-n', '0'] in directory '/root'
2017-12-10 10:13:02,574 [salt.loaded.int.module.cmdmod][INFO    ][6024] Executing command ['systemctl', 'is-active', 'opendaylight.service'] in directory '/root'
2017-12-10 10:13:02,585 [salt.loaded.int.module.cmdmod][INFO    ][6024] Executing command ['systemctl', 'is-enabled', 'opendaylight.service'] in directory '/root'
2017-12-10 10:13:02,592 [salt.state       ][INFO    ][6024] The service opendaylight is already running
2017-12-10 10:13:02,593 [salt.state       ][INFO    ][6024] Completed state [opendaylight] at time 10:13:02.592600 duration_in_ms=29.679
2017-12-10 10:13:02,593 [salt.state       ][INFO    ][6024] Running state [opendaylight] at time 10:13:02.592813
2017-12-10 10:13:02,593 [salt.state       ][INFO    ][6024] Executing state service.mod_watch for opendaylight
2017-12-10 10:13:02,594 [salt.loaded.int.module.cmdmod][INFO    ][6024] Executing command ['systemctl', 'is-active', 'opendaylight.service'] in directory '/root'
2017-12-10 10:13:02,601 [salt.loaded.int.module.cmdmod][INFO    ][6024] Executing command ['systemctl', 'is-enabled', 'opendaylight.service'] in directory '/root'
2017-12-10 10:13:02,608 [salt.loaded.int.module.cmdmod][INFO    ][6024] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'opendaylight.service'] in directory '/root'
2017-12-10 10:13:02,987 [salt.state       ][INFO    ][6024] {'opendaylight': True}
2017-12-10 10:13:02,988 [salt.state       ][INFO    ][6024] Completed state [opendaylight] at time 10:13:02.987701 duration_in_ms=394.888
2017-12-10 10:13:02,989 [salt.minion      ][INFO    ][6024] Returning information for job: 20171210100707221240
2017-12-10 11:00:49,821 [salt.utils.schedule][INFO    ][1794] Running scheduled job: __mine_interval
2017-12-10 11:22:14,177 [salt.minion      ][INFO    ][1794] User sudo_ubuntu Executing command cp.push_dir with jid 20171210112214153814
2017-12-10 11:22:14,191 [salt.minion      ][INFO    ][15452] Starting a new job with PID 15452
