2017-12-09 05:25:33,079 [salt.cli.daemons ][WARNING ][891] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-09 05:39:36,454 [salt.state       ][ERROR   ][1313] No contents found in top file
2017-12-09 05:39:45,218 [py.warnings      ][WARNING ][1410] /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-09 05:39:58,836 [salt.loaded.int.module.cmdmod][ERROR   ][1410] 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-09 05:40:00,794 [salt.loaded.int.module.cmdmod][INFO    ][1891] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-09 05:40:00,802 [salt.loaded.int.module.cmdmod][INFO    ][1891] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-09 05:40:00,813 [salt.loaded.int.module.cmdmod][INFO    ][1891] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-09 05:40:00,837 [salt.utils.parsers][WARNING ][891] Minion received a SIGTERM. Exiting.
2017-12-09 05:40:01,159 [salt.cli.daemons ][INFO    ][1947] Setting up the Salt Minion "odl01.baremetal-mcp-ocata-odl-ha.local"
2017-12-09 05:40:01,507 [salt.minion      ][INFO    ][1947] Creating minion process manager
2017-12-09 05:40:01,507 [salt.cli.daemons ][WARNING ][1947] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-09 05:40:01,507 [salt.cli.daemons ][INFO    ][1947] The Salt Minion is starting up
2017-12-09 05:40:01,508 [salt.minion      ][INFO    ][1947] Minion is starting as user 'root'
2017-12-09 05:40:01,508 [salt.utils.event ][INFO    ][1947] Starting pull socket on /var/run/salt/minion/minion_event_c4ab45d64e_pull.ipc
2017-12-09 05:40:02,806 [salt.loaded.int.module.cmdmod][INFO    ][1947] Executing command ['date', '+%z'] in directory '/root'
2017-12-09 05:40:02,821 [salt.utils.schedule][INFO    ][1947] Updating job settings for scheduled job: __mine_interval
2017-12-09 05:40:02,827 [salt.minion      ][INFO    ][1947] Added mine.update to scheduler
2017-12-09 05:40:02,852 [salt.minion      ][INFO    ][1947] Minion is ready to receive requests!
2017-12-09 05:40:03,853 [salt.utils.schedule][INFO    ][1947] Running scheduled job: __mine_interval
2017-12-09 05:40:08,672 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command state.apply with jid 20171209054008664522
2017-12-09 05:40:08,689 [salt.minion      ][INFO    ][2043] Starting a new job with PID 2043
2017-12-09 05:40:12,337 [salt.state       ][INFO    ][2043] Loading fresh modules for state activity
2017-12-09 05:40:12,674 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2017-12-09 05:40:12,695 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2017-12-09 05:40:12,808 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:12,875 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2017-12-09 05:40:12,897 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:12,958 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2017-12-09 05:40:12,978 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:13,035 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2017-12-09 05:40:13,101 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:13,319 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2017-12-09 05:40:13,356 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:13,427 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2017-12-09 05:40:13,448 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:13,521 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2017-12-09 05:40:13,571 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:13,656 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2017-12-09 05:40:13,689 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:13,760 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2017-12-09 05:40:13,781 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:13,849 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2017-12-09 05:40:13,869 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:13,929 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2017-12-09 05:40:14,870 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:14,947 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2017-12-09 05:40:14,975 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:15,032 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2017-12-09 05:40:15,049 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:15,110 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2017-12-09 05:40:15,134 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:15,209 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2017-12-09 05:40:15,239 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:15,295 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2017-12-09 05:40:15,319 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:15,380 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2017-12-09 05:40:15,430 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:15,530 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2017-12-09 05:40:15,626 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:15,687 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2017-12-09 05:40:15,709 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:15,770 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2017-12-09 05:40:15,794 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:15,854 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2017-12-09 05:40:15,871 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2017-12-09 05:40:15,893 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-09 05:40:15,916 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2017-12-09 05:40:15,940 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-09 05:40:15,956 [salt.state       ][INFO    ][2043] Running state [/etc/environment] at time 05:40:15.956260
2017-12-09 05:40:15,957 [salt.state       ][INFO    ][2043] Executing state file.blockreplace for /etc/environment
2017-12-09 05:40:15,962 [salt.state       ][INFO    ][2043] 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-09 05:40:15,963 [salt.state       ][INFO    ][2043] Completed state [/etc/environment] at time 05:40:15.962704 duration_in_ms=6.445
2017-12-09 05:40:15,963 [salt.state       ][INFO    ][2043] Running state [/etc/profile.d] at time 05:40:15.963053
2017-12-09 05:40:15,963 [salt.state       ][INFO    ][2043] Executing state file.directory for /etc/profile.d
2017-12-09 05:40:15,964 [salt.state       ][INFO    ][2043] Directory /etc/profile.d is in the correct state
2017-12-09 05:40:15,965 [salt.state       ][INFO    ][2043] Completed state [/etc/profile.d] at time 05:40:15.964735 duration_in_ms=1.682
2017-12-09 05:40:16,234 [salt.state       ][INFO    ][2043] Running state [linux_repo_prereq_pkgs] at time 05:40:16.233501
2017-12-09 05:40:16,234 [salt.state       ][INFO    ][2043] Executing state pkg.installed for linux_repo_prereq_pkgs
2017-12-09 05:40:16,235 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-09 05:40:16,680 [salt.state       ][INFO    ][2043] All specified packages are already installed
2017-12-09 05:40:16,681 [salt.state       ][INFO    ][2043] Completed state [linux_repo_prereq_pkgs] at time 05:40:16.680796 duration_in_ms=447.295
2017-12-09 05:40:16,681 [salt.state       ][INFO    ][2043] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 05:40:16.681214
2017-12-09 05:40:16,682 [salt.state       ][INFO    ][2043] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mk_openstack
2017-12-09 05:40:16,682 [salt.state       ][INFO    ][2043] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2017-12-09 05:40:16,682 [salt.state       ][INFO    ][2043] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 05:40:16.682419 duration_in_ms=1.205
2017-12-09 05:40:16,683 [salt.state       ][INFO    ][2043] Running state [/etc/apt/preferences.d/mk_openstack] at time 05:40:16.682734
2017-12-09 05:40:16,683 [salt.state       ][INFO    ][2043] Executing state file.managed for /etc/apt/preferences.d/mk_openstack
2017-12-09 05:40:16,703 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-12-09 05:40:16,720 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:16,770 [salt.state       ][INFO    ][2043] File changed:
New file
2017-12-09 05:40:16,770 [salt.state       ][INFO    ][2043] Completed state [/etc/apt/preferences.d/mk_openstack] at time 05:40:16.770307 duration_in_ms=87.572
2017-12-09 05:40:16,773 [salt.state       ][INFO    ][2043] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly ocata] at time 05:40:16.773089
2017-12-09 05:40:16,773 [salt.state       ][INFO    ][2043] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly ocata
2017-12-09 05:40:17,079 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
2017-12-09 05:40:17,203 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-09 05:40:18,689 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054018685485
2017-12-09 05:40:18,702 [salt.minion      ][INFO    ][2501] Starting a new job with PID 2501
2017-12-09 05:40:18,715 [salt.minion      ][INFO    ][2501] Returning information for job: 20171209054018685485
2017-12-09 05:40:19,393 [salt.state       ][INFO    ][2043] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly ocata'}
2017-12-09 05:40:19,394 [salt.state       ][INFO    ][2043] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly ocata] at time 05:40:19.393761 duration_in_ms=2620.67
2017-12-09 05:40:19,394 [salt.state       ][INFO    ][2043] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 05:40:19.394183
2017-12-09 05:40:19,395 [salt.state       ][INFO    ][2043] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack
2017-12-09 05:40:19,395 [salt.state       ][INFO    ][2043] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2017-12-09 05:40:19,395 [salt.state       ][INFO    ][2043] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 05:40:19.395341 duration_in_ms=1.158
2017-12-09 05:40:19,396 [salt.state       ][INFO    ][2043] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 05:40:19.395642
2017-12-09 05:40:19,396 [salt.state       ][INFO    ][2043] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack
2017-12-09 05:40:19,419 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-12-09 05:40:19,447 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:19,496 [salt.state       ][INFO    ][2043] File changed:
New file
2017-12-09 05:40:19,496 [salt.state       ][INFO    ][2043] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 05:40:19.496010 duration_in_ms=100.368
2017-12-09 05:40:19,497 [salt.state       ][INFO    ][2043] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main] at time 05:40:19.496957
2017-12-09 05:40:19,497 [salt.state       ][INFO    ][2043] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main
2017-12-09 05:40:19,883 [salt.loaded.int.module.cmdmod][INFO    ][2043] 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-09 05:40:19,992 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-09 05:40:22,905 [salt.state       ][INFO    ][2043] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main'}
2017-12-09 05:40:22,906 [salt.state       ][INFO    ][2043] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main] at time 05:40:22.905693 duration_in_ms=3408.736
2017-12-09 05:40:22,906 [salt.state       ][INFO    ][2043] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 05:40:22.906164
2017-12-09 05:40:22,907 [salt.state       ][INFO    ][2043] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2017-12-09 05:40:22,907 [salt.state       ][INFO    ][2043] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2017-12-09 05:40:22,908 [salt.state       ][INFO    ][2043] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 05:40:22.907495 duration_in_ms=1.331
2017-12-09 05:40:22,908 [salt.state       ][INFO    ][2043] Running state [/etc/apt/preferences.d/uca] at time 05:40:22.907860
2017-12-09 05:40:22,908 [salt.state       ][INFO    ][2043] Executing state file.absent for /etc/apt/preferences.d/uca
2017-12-09 05:40:22,909 [salt.state       ][INFO    ][2043] File /etc/apt/preferences.d/uca is not present
2017-12-09 05:40:22,909 [salt.state       ][INFO    ][2043] Completed state [/etc/apt/preferences.d/uca] at time 05:40:22.908937 duration_in_ms=1.076
2017-12-09 05:40:22,910 [salt.state       ][INFO    ][2043] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 05:40:22.910068
2017-12-09 05:40:22,910 [salt.state       ][INFO    ][2043] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main
2017-12-09 05:40:22,981 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['apt-key', 'export', 'EC4926EA'] in directory '/root'
2017-12-09 05:40:23,033 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['apt-key', 'adv', '--keyserver', 'keyserver.ubuntu.com', '--logger-fd', '1', '--recv-keys', 'EC4926EA'] in directory '/root'
2017-12-09 05:40:23,340 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-09 05:40:25,715 [salt.state       ][INFO    ][2043] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main'}
2017-12-09 05:40:25,716 [salt.state       ][INFO    ][2043] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 05:40:25.715945 duration_in_ms=2805.876
2017-12-09 05:40:25,716 [salt.state       ][INFO    ][2043] Running state [/etc/apt/apt.conf.d/99proxies-salt-mcp_extra] at time 05:40:25.716380
2017-12-09 05:40:25,717 [salt.state       ][INFO    ][2043] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mcp_extra
2017-12-09 05:40:25,717 [salt.state       ][INFO    ][2043] File /etc/apt/apt.conf.d/99proxies-salt-mcp_extra is not present
2017-12-09 05:40:25,718 [salt.state       ][INFO    ][2043] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mcp_extra] at time 05:40:25.717611 duration_in_ms=1.231
2017-12-09 05:40:25,718 [salt.state       ][INFO    ][2043] Running state [/etc/apt/preferences.d/mcp_extra] at time 05:40:25.717953
2017-12-09 05:40:25,718 [salt.state       ][INFO    ][2043] Executing state file.managed for /etc/apt/preferences.d/mcp_extra
2017-12-09 05:40:25,732 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-12-09 05:40:25,751 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:25,805 [salt.state       ][INFO    ][2043] File changed:
New file
2017-12-09 05:40:25,806 [salt.state       ][INFO    ][2043] Completed state [/etc/apt/preferences.d/mcp_extra] at time 05:40:25.806036 duration_in_ms=88.082
2017-12-09 05:40:25,807 [salt.state       ][INFO    ][2043] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly extra] at time 05:40:25.807310
2017-12-09 05:40:25,808 [salt.state       ][INFO    ][2043] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly extra
2017-12-09 05:40:25,954 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
2017-12-09 05:40:26,051 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-09 05:40:28,283 [salt.state       ][INFO    ][2043] Configured package repo 'deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly extra'
2017-12-09 05:40:28,284 [salt.state       ][INFO    ][2043] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly extra] at time 05:40:28.284011 duration_in_ms=2476.7
2017-12-09 05:40:28,284 [salt.state       ][INFO    ][2043] Running state [linux_extra_packages_purged] at time 05:40:28.284453
2017-12-09 05:40:28,285 [salt.state       ][INFO    ][2043] Executing state pkg.purged for linux_extra_packages_purged
2017-12-09 05:40:28,305 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', 'purge', 'cloud-init', 'unattended-upgrades'] in directory '/root'
2017-12-09 05:40:28,774 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054028766733
2017-12-09 05:40:28,794 [salt.minion      ][INFO    ][3980] Starting a new job with PID 3980
2017-12-09 05:40:29,576 [salt.minion      ][INFO    ][3980] Returning information for job: 20171209054028766733
2017-12-09 05:40:32,127 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-09 05:40:32,153 [salt.state       ][INFO    ][2043] {'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-09 05:40:32,165 [salt.state       ][INFO    ][2043] Loading fresh modules for state activity
2017-12-09 05:40:32,184 [salt.state       ][INFO    ][2043] Completed state [linux_extra_packages_purged] at time 05:40:32.183498 duration_in_ms=3899.045
2017-12-09 05:40:32,190 [salt.state       ][INFO    ][2043] Running state [linux_extra_packages_latest] at time 05:40:32.189583
2017-12-09 05:40:32,190 [salt.state       ][INFO    ][2043] Executing state pkg.latest for linux_extra_packages_latest
2017-12-09 05:40:32,437 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-09 05:40:34,422 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['apt-cache', '-q', 'policy', 'mcelog'] in directory '/root'
2017-12-09 05:40:34,474 [salt.loaded.int.module.cmdmod][INFO    ][2043] 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-09 05:40:36,273 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-09 05:40:36,297 [salt.state       ][INFO    ][2043] Made the following changes:
'mcelog' changed from 'absent' to '128+dfsg-1'

2017-12-09 05:40:36,309 [salt.state       ][INFO    ][2043] Loading fresh modules for state activity
2017-12-09 05:40:36,328 [salt.state       ][INFO    ][2043] Completed state [linux_extra_packages_latest] at time 05:40:36.328067 duration_in_ms=4138.483
2017-12-09 05:40:36,332 [salt.state       ][INFO    ][2043] Running state [UTC] at time 05:40:36.332144
2017-12-09 05:40:36,333 [salt.state       ][INFO    ][2043] Executing state timezone.system for UTC
2017-12-09 05:40:36,335 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['timedatectl'] in directory '/root'
2017-12-09 05:40:36,397 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['timedatectl'] in directory '/root'
2017-12-09 05:40:36,407 [salt.state       ][INFO    ][2043] Timezone UTC already set, UTC already set to UTC
2017-12-09 05:40:36,408 [salt.state       ][INFO    ][2043] Completed state [UTC] at time 05:40:36.407529 duration_in_ms=75.384
2017-12-09 05:40:36,410 [salt.state       ][INFO    ][2043] Running state [nf_conntrack] at time 05:40:36.410450
2017-12-09 05:40:36,411 [salt.state       ][INFO    ][2043] Executing state kmod.present for nf_conntrack
2017-12-09 05:40:36,411 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'lsmod' in directory '/root'
2017-12-09 05:40:36,788 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'lsmod' in directory '/root'
2017-12-09 05:40:36,797 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'modprobe nf_conntrack' in directory '/root'
2017-12-09 05:40:36,815 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'lsmod' in directory '/root'
2017-12-09 05:40:36,877 [salt.state       ][INFO    ][2043] {'nf_conntrack': 'loaded'}
2017-12-09 05:40:36,878 [salt.state       ][INFO    ][2043] Completed state [nf_conntrack] at time 05:40:36.877558 duration_in_ms=467.107
2017-12-09 05:40:36,881 [salt.state       ][INFO    ][2043] Running state [kernel.panic] at time 05:40:36.880854
2017-12-09 05:40:36,881 [salt.state       ][INFO    ][2043] Executing state sysctl.present for kernel.panic
2017-12-09 05:40:36,882 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:36,929 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2017-12-09 05:40:36,941 [salt.state       ][INFO    ][2043] {'kernel.panic': 60}
2017-12-09 05:40:36,941 [salt.state       ][INFO    ][2043] Completed state [kernel.panic] at time 05:40:36.940969 duration_in_ms=60.114
2017-12-09 05:40:36,941 [salt.state       ][INFO    ][2043] Running state [net.ipv4.tcp_keepalive_probes] at time 05:40:36.941325
2017-12-09 05:40:36,942 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2017-12-09 05:40:36,942 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:36,968 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2017-12-09 05:40:36,979 [salt.state       ][INFO    ][2043] {'net.ipv4.tcp_keepalive_probes': 8}
2017-12-09 05:40:36,980 [salt.state       ][INFO    ][2043] Completed state [net.ipv4.tcp_keepalive_probes] at time 05:40:36.979946 duration_in_ms=38.62
2017-12-09 05:40:36,980 [salt.state       ][INFO    ][2043] Running state [fs.file-max] at time 05:40:36.980227
2017-12-09 05:40:36,981 [salt.state       ][INFO    ][2043] Executing state sysctl.present for fs.file-max
2017-12-09 05:40:36,981 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,001 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2017-12-09 05:40:37,012 [salt.state       ][INFO    ][2043] {'fs.file-max': 124165}
2017-12-09 05:40:37,013 [salt.state       ][INFO    ][2043] Completed state [fs.file-max] at time 05:40:37.012526 duration_in_ms=32.298
2017-12-09 05:40:37,013 [salt.state       ][INFO    ][2043] Running state [net.core.somaxconn] at time 05:40:37.013114
2017-12-09 05:40:37,014 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.core.somaxconn
2017-12-09 05:40:37,015 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,036 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2017-12-09 05:40:37,047 [salt.state       ][INFO    ][2043] {'net.core.somaxconn': 4096}
2017-12-09 05:40:37,047 [salt.state       ][INFO    ][2043] Completed state [net.core.somaxconn] at time 05:40:37.047212 duration_in_ms=34.097
2017-12-09 05:40:37,048 [salt.state       ][INFO    ][2043] Running state [net.ipv4.tcp_max_syn_backlog] at time 05:40:37.047655
2017-12-09 05:40:37,048 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2017-12-09 05:40:37,049 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,069 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2017-12-09 05:40:37,079 [salt.state       ][INFO    ][2043] {'net.ipv4.tcp_max_syn_backlog': 8192}
2017-12-09 05:40:37,080 [salt.state       ][INFO    ][2043] Completed state [net.ipv4.tcp_max_syn_backlog] at time 05:40:37.079480 duration_in_ms=31.824
2017-12-09 05:40:37,080 [salt.state       ][INFO    ][2043] Running state [net.ipv4.tcp_tw_reuse] at time 05:40:37.079936
2017-12-09 05:40:37,080 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2017-12-09 05:40:37,081 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,100 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2017-12-09 05:40:37,110 [salt.state       ][INFO    ][2043] {'net.ipv4.tcp_tw_reuse': 1}
2017-12-09 05:40:37,111 [salt.state       ][INFO    ][2043] Completed state [net.ipv4.tcp_tw_reuse] at time 05:40:37.110889 duration_in_ms=30.943
2017-12-09 05:40:37,111 [salt.state       ][INFO    ][2043] Running state [net.ipv4.tcp_congestion_control] at time 05:40:37.111337
2017-12-09 05:40:37,112 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2017-12-09 05:40:37,112 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,129 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2017-12-09 05:40:37,144 [salt.state       ][INFO    ][2043] {'net.ipv4.tcp_congestion_control': 'yeah'}
2017-12-09 05:40:37,144 [salt.state       ][INFO    ][2043] Completed state [net.ipv4.tcp_congestion_control] at time 05:40:37.144345 duration_in_ms=33.008
2017-12-09 05:40:37,145 [salt.state       ][INFO    ][2043] Running state [net.ipv4.tcp_retries2] at time 05:40:37.144813
2017-12-09 05:40:37,145 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.ipv4.tcp_retries2
2017-12-09 05:40:37,146 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,164 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2017-12-09 05:40:37,173 [salt.state       ][INFO    ][2043] {'net.ipv4.tcp_retries2': 5}
2017-12-09 05:40:37,174 [salt.state       ][INFO    ][2043] Completed state [net.ipv4.tcp_retries2] at time 05:40:37.173661 duration_in_ms=28.847
2017-12-09 05:40:37,174 [salt.state       ][INFO    ][2043] Running state [net.core.netdev_max_backlog] at time 05:40:37.174149
2017-12-09 05:40:37,175 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.core.netdev_max_backlog
2017-12-09 05:40:37,175 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,192 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2017-12-09 05:40:37,202 [salt.state       ][INFO    ][2043] {'net.core.netdev_max_backlog': 261144}
2017-12-09 05:40:37,202 [salt.state       ][INFO    ][2043] Completed state [net.core.netdev_max_backlog] at time 05:40:37.202220 duration_in_ms=28.07
2017-12-09 05:40:37,203 [salt.state       ][INFO    ][2043] Running state [net.ipv4.tcp_slow_start_after_idle] at time 05:40:37.202713
2017-12-09 05:40:37,203 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2017-12-09 05:40:37,204 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,221 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2017-12-09 05:40:37,231 [salt.state       ][INFO    ][2043] {'net.ipv4.tcp_slow_start_after_idle': 0}
2017-12-09 05:40:37,232 [salt.state       ][INFO    ][2043] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 05:40:37.231855 duration_in_ms=29.131
2017-12-09 05:40:37,232 [salt.state       ][INFO    ][2043] Running state [vm.swappiness] at time 05:40:37.232315
2017-12-09 05:40:37,233 [salt.state       ][INFO    ][2043] Executing state sysctl.present for vm.swappiness
2017-12-09 05:40:37,233 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,251 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2017-12-09 05:40:37,260 [salt.state       ][INFO    ][2043] {'vm.swappiness': 10}
2017-12-09 05:40:37,261 [salt.state       ][INFO    ][2043] Completed state [vm.swappiness] at time 05:40:37.260497 duration_in_ms=28.181
2017-12-09 05:40:37,261 [salt.state       ][INFO    ][2043] Running state [net.ipv4.tcp_keepalive_intvl] at time 05:40:37.260939
2017-12-09 05:40:37,261 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2017-12-09 05:40:37,262 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,280 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2017-12-09 05:40:37,287 [salt.state       ][INFO    ][2043] {'net.ipv4.tcp_keepalive_intvl': 3}
2017-12-09 05:40:37,288 [salt.state       ][INFO    ][2043] Completed state [net.ipv4.tcp_keepalive_intvl] at time 05:40:37.287780 duration_in_ms=26.841
2017-12-09 05:40:37,288 [salt.state       ][INFO    ][2043] Running state [net.ipv4.neigh.default.gc_thresh1] at time 05:40:37.288177
2017-12-09 05:40:37,289 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2017-12-09 05:40:37,289 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,315 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2017-12-09 05:40:37,324 [salt.state       ][INFO    ][2043] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2017-12-09 05:40:37,324 [salt.state       ][INFO    ][2043] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 05:40:37.324289 duration_in_ms=36.111
2017-12-09 05:40:37,325 [salt.state       ][INFO    ][2043] Running state [net.ipv4.neigh.default.gc_thresh2] at time 05:40:37.324698
2017-12-09 05:40:37,325 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2017-12-09 05:40:37,326 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,343 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2017-12-09 05:40:37,351 [salt.state       ][INFO    ][2043] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2017-12-09 05:40:37,352 [salt.state       ][INFO    ][2043] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 05:40:37.351700 duration_in_ms=27.001
2017-12-09 05:40:37,352 [salt.state       ][INFO    ][2043] Running state [net.ipv4.neigh.default.gc_thresh3] at time 05:40:37.352103
2017-12-09 05:40:37,353 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2017-12-09 05:40:37,353 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,369 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2017-12-09 05:40:37,377 [salt.state       ][INFO    ][2043] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2017-12-09 05:40:37,377 [salt.state       ][INFO    ][2043] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 05:40:37.377389 duration_in_ms=25.285
2017-12-09 05:40:37,378 [salt.state       ][INFO    ][2043] Running state [net.ipv4.tcp_fin_timeout] at time 05:40:37.377794
2017-12-09 05:40:37,378 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2017-12-09 05:40:37,379 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,396 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2017-12-09 05:40:37,404 [salt.state       ][INFO    ][2043] {'net.ipv4.tcp_fin_timeout': 30}
2017-12-09 05:40:37,404 [salt.state       ][INFO    ][2043] Completed state [net.ipv4.tcp_fin_timeout] at time 05:40:37.404222 duration_in_ms=26.427
2017-12-09 05:40:37,405 [salt.state       ][INFO    ][2043] Running state [net.ipv4.tcp_keepalive_time] at time 05:40:37.404621
2017-12-09 05:40:37,405 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2017-12-09 05:40:37,406 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,421 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2017-12-09 05:40:37,429 [salt.state       ][INFO    ][2043] {'net.ipv4.tcp_keepalive_time': 30}
2017-12-09 05:40:37,429 [salt.state       ][INFO    ][2043] Completed state [net.ipv4.tcp_keepalive_time] at time 05:40:37.429371 duration_in_ms=24.75
2017-12-09 05:40:37,430 [salt.state       ][INFO    ][2043] Running state [net.nf_conntrack_max] at time 05:40:37.429766
2017-12-09 05:40:37,430 [salt.state       ][INFO    ][2043] Executing state sysctl.present for net.nf_conntrack_max
2017-12-09 05:40:37,431 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -a' in directory '/root'
2017-12-09 05:40:37,447 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2017-12-09 05:40:37,456 [salt.state       ][INFO    ][2043] {'net.nf_conntrack_max': 1048576}
2017-12-09 05:40:37,456 [salt.state       ][INFO    ][2043] Completed state [net.nf_conntrack_max] at time 05:40:37.456046 duration_in_ms=26.279
2017-12-09 05:40:37,462 [salt.state       ][INFO    ][2043] Running state [linux_sysfs_package] at time 05:40:37.462273
2017-12-09 05:40:37,463 [salt.state       ][INFO    ][2043] Executing state pkg.installed for linux_sysfs_package
2017-12-09 05:40:37,704 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2017-12-09 05:40:37,755 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-09 05:40:38,819 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054038814043
2017-12-09 05:40:38,837 [salt.minion      ][INFO    ][5341] Starting a new job with PID 5341
2017-12-09 05:40:38,848 [salt.minion      ][INFO    ][5341] Returning information for job: 20171209054038814043
2017-12-09 05:40:39,887 [salt.loaded.int.module.cmdmod][INFO    ][2043] 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-09 05:40:41,960 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-09 05:40:41,988 [salt.state       ][INFO    ][2043] 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-09 05:40:41,999 [salt.state       ][INFO    ][2043] Loading fresh modules for state activity
2017-12-09 05:40:42,019 [salt.state       ][INFO    ][2043] Completed state [linux_sysfs_package] at time 05:40:42.018840 duration_in_ms=4556.567
2017-12-09 05:40:42,022 [salt.state       ][INFO    ][2043] Running state [/etc/sysfs.d] at time 05:40:42.022248
2017-12-09 05:40:42,023 [salt.state       ][INFO    ][2043] Executing state file.directory for /etc/sysfs.d
2017-12-09 05:40:42,025 [salt.state       ][INFO    ][2043] Directory /etc/sysfs.d is in the correct state
2017-12-09 05:40:42,026 [salt.state       ][INFO    ][2043] Completed state [/etc/sysfs.d] at time 05:40:42.025700 duration_in_ms=3.452
2017-12-09 05:40:42,111 [salt.state       ][INFO    ][2043] Running state [ondemand] at time 05:40:42.111283
2017-12-09 05:40:42,112 [salt.state       ][INFO    ][2043] Executing state service.dead for ondemand
2017-12-09 05:40:42,114 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2017-12-09 05:40:42,125 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2017-12-09 05:40:42,134 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-12-09 05:40:42,147 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2017-12-09 05:40:42,199 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2017-12-09 05:40:42,210 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-12-09 05:40:42,225 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-12-09 05:40:42,241 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2017-12-09 05:40:42,333 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-12-09 05:40:42,346 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'runlevel' in directory '/root'
2017-12-09 05:40:42,354 [salt.state       ][INFO    ][2043] {'ondemand': True}
2017-12-09 05:40:42,355 [salt.state       ][INFO    ][2043] Completed state [ondemand] at time 05:40:42.354937 duration_in_ms=243.655
2017-12-09 05:40:42,357 [salt.state       ][INFO    ][2043] Running state [cs_CZ.UTF-8] at time 05:40:42.356611
2017-12-09 05:40:42,357 [salt.state       ][INFO    ][2043] Executing state locale.present for cs_CZ.UTF-8
2017-12-09 05:40:42,358 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'locale -a' in directory '/root'
2017-12-09 05:40:42,371 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['locale-gen', 'cs_CZ.UTF-8'] in directory '/root'
2017-12-09 05:40:43,018 [salt.state       ][INFO    ][2043] {'locale': 'cs_CZ.UTF-8'}
2017-12-09 05:40:43,019 [salt.state       ][INFO    ][2043] Completed state [cs_CZ.UTF-8] at time 05:40:43.018574 duration_in_ms=661.962
2017-12-09 05:40:43,019 [salt.state       ][INFO    ][2043] Running state [en_US.UTF-8] at time 05:40:43.019016
2017-12-09 05:40:43,019 [salt.state       ][INFO    ][2043] Executing state locale.present for en_US.UTF-8
2017-12-09 05:40:43,020 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'locale -a' in directory '/root'
2017-12-09 05:40:43,029 [salt.state       ][INFO    ][2043] Locale en_US.UTF-8 is already present
2017-12-09 05:40:43,029 [salt.state       ][INFO    ][2043] Completed state [en_US.UTF-8] at time 05:40:43.029401 duration_in_ms=10.385
2017-12-09 05:40:43,031 [salt.state       ][INFO    ][2043] Running state [en_US.UTF-8] at time 05:40:43.031305
2017-12-09 05:40:43,032 [salt.state       ][INFO    ][2043] Executing state locale.system for en_US.UTF-8
2017-12-09 05:40:43,032 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'localectl' in directory '/root'
2017-12-09 05:40:43,084 [salt.state       ][INFO    ][2043] System locale en_US.UTF-8 already set
2017-12-09 05:40:43,084 [salt.state       ][INFO    ][2043] Completed state [en_US.UTF-8] at time 05:40:43.083843 duration_in_ms=52.537
2017-12-09 05:40:43,086 [salt.state       ][INFO    ][2043] Running state [root] at time 05:40:43.086383
2017-12-09 05:40:43,087 [salt.state       ][INFO    ][2043] Executing state user.present for root
2017-12-09 05:40:43,093 [salt.state       ][INFO    ][2043] {'passwd': 'XXX-REDACTED-XXX', 'lstchg': 17509}
2017-12-09 05:40:43,093 [salt.state       ][INFO    ][2043] Completed state [root] at time 05:40:43.093222 duration_in_ms=6.839
2017-12-09 05:40:43,095 [salt.state       ][INFO    ][2043] Running state [/root] at time 05:40:43.094557
2017-12-09 05:40:43,095 [salt.state       ][INFO    ][2043] Executing state file.directory for /root
2017-12-09 05:40:43,096 [salt.state       ][INFO    ][2043] Directory /root is in the correct state
2017-12-09 05:40:43,096 [salt.state       ][INFO    ][2043] Completed state [/root] at time 05:40:43.095931 duration_in_ms=1.374
2017-12-09 05:40:43,096 [salt.state       ][INFO    ][2043] Running state [/etc/sudoers.d/90-salt-user-root] at time 05:40:43.096288
2017-12-09 05:40:43,097 [salt.state       ][INFO    ][2043] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2017-12-09 05:40:43,097 [salt.state       ][INFO    ][2043] File /etc/sudoers.d/90-salt-user-root is not present
2017-12-09 05:40:43,098 [salt.state       ][INFO    ][2043] Completed state [/etc/sudoers.d/90-salt-user-root] at time 05:40:43.097481 duration_in_ms=1.193
2017-12-09 05:40:43,098 [salt.state       ][INFO    ][2043] Running state [ubuntu] at time 05:40:43.097800
2017-12-09 05:40:43,098 [salt.state       ][INFO    ][2043] Executing state user.present for ubuntu
2017-12-09 05:40:43,099 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['useradd', '-s', '/bin/bash', '-m', '-d', '/home/ubuntu', 'ubuntu'] in directory '/root'
2017-12-09 05:40:43,160 [salt.state       ][INFO    ][2043] {'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-09 05:40:43,161 [salt.state       ][INFO    ][2043] Completed state [ubuntu] at time 05:40:43.160448 duration_in_ms=62.647
2017-12-09 05:40:43,163 [salt.state       ][INFO    ][2043] Running state [/home/ubuntu] at time 05:40:43.162737
2017-12-09 05:40:43,163 [salt.state       ][INFO    ][2043] Executing state file.directory for /home/ubuntu
2017-12-09 05:40:43,165 [salt.state       ][INFO    ][2043] {'mode': '0700'}
2017-12-09 05:40:43,165 [salt.state       ][INFO    ][2043] Completed state [/home/ubuntu] at time 05:40:43.165215 duration_in_ms=2.477
2017-12-09 05:40:43,167 [salt.state       ][INFO    ][2043] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 05:40:43.166904
2017-12-09 05:40:43,167 [salt.state       ][INFO    ][2043] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2017-12-09 05:40:43,183 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2017-12-09 05:40:43,187 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command '/usr/sbin/visudo -c -f /tmp/tmpktX7Gk' in directory '/root'
2017-12-09 05:40:43,200 [salt.state       ][INFO    ][2043] File changed:
New file
2017-12-09 05:40:43,201 [salt.state       ][INFO    ][2043] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 05:40:43.200903 duration_in_ms=33.998
2017-12-09 05:40:43,201 [salt.state       ][INFO    ][2043] Running state [/etc/security/limits.d/90-salt-default.conf] at time 05:40:43.201324
2017-12-09 05:40:43,202 [salt.state       ][INFO    ][2043] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2017-12-09 05:40:43,215 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2017-12-09 05:40:43,235 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:43,289 [salt.state       ][INFO    ][2043] File changed:
New file
2017-12-09 05:40:43,290 [salt.state       ][INFO    ][2043] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 05:40:43.289929 duration_in_ms=88.603
2017-12-09 05:40:43,290 [salt.state       ][INFO    ][2043] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 05:40:43.290369
2017-12-09 05:40:43,291 [salt.state       ][INFO    ][2043] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2017-12-09 05:40:43,305 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2017-12-09 05:40:43,322 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-09 05:40:43,375 [salt.state       ][INFO    ][2043] File changed:
New file
2017-12-09 05:40:43,376 [salt.state       ][INFO    ][2043] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 05:40:43.375650 duration_in_ms=85.28
2017-12-09 05:40:43,377 [salt.state       ][INFO    ][2043] Running state [service.systemctl_reload] at time 05:40:43.377142
2017-12-09 05:40:43,378 [salt.state       ][INFO    ][2043] Executing state module.wait for service.systemctl_reload
2017-12-09 05:40:43,378 [salt.state       ][INFO    ][2043] No changes made for service.systemctl_reload
2017-12-09 05:40:43,378 [salt.state       ][INFO    ][2043] Completed state [service.systemctl_reload] at time 05:40:43.378210 duration_in_ms=1.068
2017-12-09 05:40:43,379 [salt.state       ][INFO    ][2043] Running state [service.systemctl_reload] at time 05:40:43.378527
2017-12-09 05:40:43,379 [salt.state       ][INFO    ][2043] Executing state module.mod_watch for service.systemctl_reload
2017-12-09 05:40:43,379 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-09 05:40:43,428 [salt.state       ][INFO    ][2043] {'ret': True}
2017-12-09 05:40:43,428 [salt.state       ][INFO    ][2043] Completed state [service.systemctl_reload] at time 05:40:43.427997 duration_in_ms=49.469
2017-12-09 05:40:43,428 [salt.state       ][INFO    ][2043] Running state [/etc/hostname] at time 05:40:43.428335
2017-12-09 05:40:43,429 [salt.state       ][INFO    ][2043] Executing state file.managed for /etc/hostname
2017-12-09 05:40:43,445 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2017-12-09 05:40:43,448 [salt.state       ][INFO    ][2043] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu-1604
+odl01

2017-12-09 05:40:43,448 [salt.state       ][INFO    ][2043] Completed state [/etc/hostname] at time 05:40:43.447834 duration_in_ms=19.498
2017-12-09 05:40:43,450 [salt.state       ][INFO    ][2043] Running state [hostname odl01] at time 05:40:43.449589
2017-12-09 05:40:43,450 [salt.state       ][INFO    ][2043] Executing state cmd.wait for hostname odl01
2017-12-09 05:40:43,450 [salt.state       ][INFO    ][2043] No changes made for hostname odl01
2017-12-09 05:40:43,450 [salt.state       ][INFO    ][2043] Completed state [hostname odl01] at time 05:40:43.450246 duration_in_ms=0.657
2017-12-09 05:40:43,450 [salt.state       ][INFO    ][2043] Running state [hostname odl01] at time 05:40:43.450441
2017-12-09 05:40:43,451 [salt.state       ][INFO    ][2043] Executing state cmd.mod_watch for hostname odl01
2017-12-09 05:40:43,451 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command 'hostname odl01' in directory '/root'
2017-12-09 05:40:43,459 [salt.state       ][INFO    ][2043] {'pid': 5609, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-09 05:40:43,459 [salt.state       ][INFO    ][2043] Completed state [hostname odl01] at time 05:40:43.459275 duration_in_ms=8.833
2017-12-09 05:40:43,461 [salt.state       ][INFO    ][2043] Running state [mdb02.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.460680
2017-12-09 05:40:43,461 [salt.state       ][INFO    ][2043] Executing state host.present for mdb02.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,463 [salt.state       ][INFO    ][2043] {'host': 'mdb02.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,463 [salt.state       ][INFO    ][2043] Completed state [mdb02.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.462959 duration_in_ms=2.279
2017-12-09 05:40:43,463 [salt.state       ][INFO    ][2043] Running state [mdb02] at time 05:40:43.463166
2017-12-09 05:40:43,463 [salt.state       ][INFO    ][2043] Executing state host.present for mdb02
2017-12-09 05:40:43,464 [salt.state       ][INFO    ][2043] {'host': 'mdb02'}
2017-12-09 05:40:43,464 [salt.state       ][INFO    ][2043] Completed state [mdb02] at time 05:40:43.464193 duration_in_ms=1.027
2017-12-09 05:40:43,464 [salt.state       ][INFO    ][2043] Running state [mdb03.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.464391
2017-12-09 05:40:43,465 [salt.state       ][INFO    ][2043] Executing state host.present for mdb03.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,465 [salt.state       ][INFO    ][2043] {'host': 'mdb03.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,465 [salt.state       ][INFO    ][2043] Completed state [mdb03.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.465392 duration_in_ms=1.001
2017-12-09 05:40:43,466 [salt.state       ][INFO    ][2043] Running state [mdb03] at time 05:40:43.465594
2017-12-09 05:40:43,466 [salt.state       ][INFO    ][2043] Executing state host.present for mdb03
2017-12-09 05:40:43,467 [salt.state       ][INFO    ][2043] {'host': 'mdb03'}
2017-12-09 05:40:43,467 [salt.state       ][INFO    ][2043] Completed state [mdb03] at time 05:40:43.466702 duration_in_ms=1.106
2017-12-09 05:40:43,467 [salt.state       ][INFO    ][2043] Running state [mdb01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.466971
2017-12-09 05:40:43,467 [salt.state       ][INFO    ][2043] Executing state host.present for mdb01.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,468 [salt.state       ][INFO    ][2043] {'host': 'mdb01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,468 [salt.state       ][INFO    ][2043] Completed state [mdb01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.468001 duration_in_ms=1.03
2017-12-09 05:40:43,468 [salt.state       ][INFO    ][2043] Running state [mdb01] at time 05:40:43.468195
2017-12-09 05:40:43,468 [salt.state       ][INFO    ][2043] Executing state host.present for mdb01
2017-12-09 05:40:43,469 [salt.state       ][INFO    ][2043] {'host': 'mdb01'}
2017-12-09 05:40:43,469 [salt.state       ][INFO    ][2043] Completed state [mdb01] at time 05:40:43.469171 duration_in_ms=0.976
2017-12-09 05:40:43,469 [salt.state       ][INFO    ][2043] Running state [mdb] at time 05:40:43.469380
2017-12-09 05:40:43,470 [salt.state       ][INFO    ][2043] Executing state host.present for mdb
2017-12-09 05:40:43,470 [salt.state       ][INFO    ][2043] {'host': 'mdb'}
2017-12-09 05:40:43,470 [salt.state       ][INFO    ][2043] Completed state [mdb] at time 05:40:43.470406 duration_in_ms=1.026
2017-12-09 05:40:43,471 [salt.state       ][INFO    ][2043] Running state [mdb.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.470620
2017-12-09 05:40:43,471 [salt.state       ][INFO    ][2043] Executing state host.present for mdb.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,471 [salt.state       ][INFO    ][2043] {'host': 'mdb.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,472 [salt.state       ][INFO    ][2043] Completed state [mdb.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.471639 duration_in_ms=1.019
2017-12-09 05:40:43,472 [salt.state       ][INFO    ][2043] Running state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.471827
2017-12-09 05:40:43,472 [salt.state       ][INFO    ][2043] Executing state host.present for cfg01.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,473 [salt.state       ][INFO    ][2043] {'host': 'cfg01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,473 [salt.state       ][INFO    ][2043] Completed state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.472859 duration_in_ms=1.032
2017-12-09 05:40:43,473 [salt.state       ][INFO    ][2043] Running state [cfg01] at time 05:40:43.473057
2017-12-09 05:40:43,473 [salt.state       ][INFO    ][2043] Executing state host.present for cfg01
2017-12-09 05:40:43,474 [salt.state       ][INFO    ][2043] {'host': 'cfg01'}
2017-12-09 05:40:43,474 [salt.state       ][INFO    ][2043] Completed state [cfg01] at time 05:40:43.474107 duration_in_ms=1.05
2017-12-09 05:40:43,474 [salt.state       ][INFO    ][2043] Running state [prx01] at time 05:40:43.474337
2017-12-09 05:40:43,475 [salt.state       ][INFO    ][2043] Executing state host.present for prx01
2017-12-09 05:40:43,475 [salt.state       ][INFO    ][2043] {'host': 'prx01'}
2017-12-09 05:40:43,475 [salt.state       ][INFO    ][2043] Completed state [prx01] at time 05:40:43.475399 duration_in_ms=1.062
2017-12-09 05:40:43,476 [salt.state       ][INFO    ][2043] Running state [prx01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.475613
2017-12-09 05:40:43,476 [salt.state       ][INFO    ][2043] Executing state host.present for prx01.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,477 [salt.state       ][INFO    ][2043] {'host': 'prx01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,477 [salt.state       ][INFO    ][2043] Completed state [prx01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.476674 duration_in_ms=1.061
2017-12-09 05:40:43,477 [salt.state       ][INFO    ][2043] Running state [kvm01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.476873
2017-12-09 05:40:43,477 [salt.state       ][INFO    ][2043] Executing state host.present for kvm01.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,478 [salt.state       ][INFO    ][2043] {'host': 'kvm01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,478 [salt.state       ][INFO    ][2043] Completed state [kvm01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.477948 duration_in_ms=1.075
2017-12-09 05:40:43,478 [salt.state       ][INFO    ][2043] Running state [kvm01] at time 05:40:43.478200
2017-12-09 05:40:43,478 [salt.state       ][INFO    ][2043] Executing state host.present for kvm01
2017-12-09 05:40:43,479 [salt.state       ][INFO    ][2043] {'host': 'kvm01'}
2017-12-09 05:40:43,479 [salt.state       ][INFO    ][2043] Completed state [kvm01] at time 05:40:43.479300 duration_in_ms=1.1
2017-12-09 05:40:43,480 [salt.state       ][INFO    ][2043] Running state [kvm03.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.479493
2017-12-09 05:40:43,480 [salt.state       ][INFO    ][2043] Executing state host.present for kvm03.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,480 [salt.state       ][INFO    ][2043] {'host': 'kvm03.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,481 [salt.state       ][INFO    ][2043] Completed state [kvm03.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.480576 duration_in_ms=1.083
2017-12-09 05:40:43,481 [salt.state       ][INFO    ][2043] Running state [kvm03] at time 05:40:43.480769
2017-12-09 05:40:43,481 [salt.state       ][INFO    ][2043] Executing state host.present for kvm03
2017-12-09 05:40:43,482 [salt.state       ][INFO    ][2043] {'host': 'kvm03'}
2017-12-09 05:40:43,482 [salt.state       ][INFO    ][2043] Completed state [kvm03] at time 05:40:43.481837 duration_in_ms=1.068
2017-12-09 05:40:43,482 [salt.state       ][INFO    ][2043] Running state [kvm02.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.482052
2017-12-09 05:40:43,482 [salt.state       ][INFO    ][2043] Executing state host.present for kvm02.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,483 [salt.state       ][INFO    ][2043] {'host': 'kvm02.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,483 [salt.state       ][INFO    ][2043] Completed state [kvm02.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.483191 duration_in_ms=1.139
2017-12-09 05:40:43,483 [salt.state       ][INFO    ][2043] Running state [kvm02] at time 05:40:43.483388
2017-12-09 05:40:43,484 [salt.state       ][INFO    ][2043] Executing state host.present for kvm02
2017-12-09 05:40:43,485 [salt.state       ][INFO    ][2043] {'host': 'kvm02'}
2017-12-09 05:40:43,485 [salt.state       ][INFO    ][2043] Completed state [kvm02] at time 05:40:43.484778 duration_in_ms=1.39
2017-12-09 05:40:43,485 [salt.state       ][INFO    ][2043] Running state [dbs] at time 05:40:43.484977
2017-12-09 05:40:43,485 [salt.state       ][INFO    ][2043] Executing state host.present for dbs
2017-12-09 05:40:43,486 [salt.state       ][INFO    ][2043] {'host': 'dbs'}
2017-12-09 05:40:43,486 [salt.state       ][INFO    ][2043] Completed state [dbs] at time 05:40:43.486121 duration_in_ms=1.144
2017-12-09 05:40:43,486 [salt.state       ][INFO    ][2043] Running state [dbs.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.486330
2017-12-09 05:40:43,487 [salt.state       ][INFO    ][2043] Executing state host.present for dbs.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,487 [salt.state       ][INFO    ][2043] {'host': 'dbs.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,487 [salt.state       ][INFO    ][2043] Completed state [dbs.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.487431 duration_in_ms=1.101
2017-12-09 05:40:43,488 [salt.state       ][INFO    ][2043] Running state [prx.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.487629
2017-12-09 05:40:43,488 [salt.state       ][INFO    ][2043] Executing state host.present for prx.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,489 [salt.state       ][INFO    ][2043] {'host': 'prx.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,489 [salt.state       ][INFO    ][2043] Completed state [prx.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.488744 duration_in_ms=1.114
2017-12-09 05:40:43,489 [salt.state       ][INFO    ][2043] Running state [prx] at time 05:40:43.488941
2017-12-09 05:40:43,489 [salt.state       ][INFO    ][2043] Executing state host.present for prx
2017-12-09 05:40:43,490 [salt.state       ][INFO    ][2043] {'host': 'prx'}
2017-12-09 05:40:43,490 [salt.state       ][INFO    ][2043] Completed state [prx] at time 05:40:43.490055 duration_in_ms=1.114
2017-12-09 05:40:43,490 [salt.state       ][INFO    ][2043] Running state [prx02] at time 05:40:43.490258
2017-12-09 05:40:43,490 [salt.state       ][INFO    ][2043] Executing state host.present for prx02
2017-12-09 05:40:43,491 [salt.state       ][INFO    ][2043] {'host': 'prx02'}
2017-12-09 05:40:43,491 [salt.state       ][INFO    ][2043] Completed state [prx02] at time 05:40:43.491399 duration_in_ms=1.141
2017-12-09 05:40:43,492 [salt.state       ][INFO    ][2043] Running state [prx02.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.491611
2017-12-09 05:40:43,492 [salt.state       ][INFO    ][2043] Executing state host.present for prx02.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,493 [salt.state       ][INFO    ][2043] {'host': 'prx02.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,493 [salt.state       ][INFO    ][2043] Completed state [prx02.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.492740 duration_in_ms=1.129
2017-12-09 05:40:43,493 [salt.state       ][INFO    ][2043] Running state [msg02.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.492953
2017-12-09 05:40:43,493 [salt.state       ][INFO    ][2043] Executing state host.present for msg02.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,494 [salt.state       ][INFO    ][2043] {'host': 'msg02.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,494 [salt.state       ][INFO    ][2043] Completed state [msg02.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.494133 duration_in_ms=1.18
2017-12-09 05:40:43,494 [salt.state       ][INFO    ][2043] Running state [msg02] at time 05:40:43.494368
2017-12-09 05:40:43,495 [salt.state       ][INFO    ][2043] Executing state host.present for msg02
2017-12-09 05:40:43,495 [salt.state       ][INFO    ][2043] {'host': 'msg02'}
2017-12-09 05:40:43,496 [salt.state       ][INFO    ][2043] Completed state [msg02] at time 05:40:43.495542 duration_in_ms=1.174
2017-12-09 05:40:43,496 [salt.state       ][INFO    ][2043] Running state [msg03.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.495738
2017-12-09 05:40:43,496 [salt.state       ][INFO    ][2043] Executing state host.present for msg03.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,497 [salt.state       ][INFO    ][2043] {'host': 'msg03.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,497 [salt.state       ][INFO    ][2043] Completed state [msg03.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.496883 duration_in_ms=1.145
2017-12-09 05:40:43,497 [salt.state       ][INFO    ][2043] Running state [msg03] at time 05:40:43.497101
2017-12-09 05:40:43,497 [salt.state       ][INFO    ][2043] Executing state host.present for msg03
2017-12-09 05:40:43,498 [salt.state       ][INFO    ][2043] {'host': 'msg03'}
2017-12-09 05:40:43,498 [salt.state       ][INFO    ][2043] Completed state [msg03] at time 05:40:43.498305 duration_in_ms=1.203
2017-12-09 05:40:43,499 [salt.state       ][INFO    ][2043] Running state [msg01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.498524
2017-12-09 05:40:43,499 [salt.state       ][INFO    ][2043] Executing state host.present for msg01.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,500 [salt.state       ][INFO    ][2043] {'host': 'msg01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,500 [salt.state       ][INFO    ][2043] Completed state [msg01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.499708 duration_in_ms=1.183
2017-12-09 05:40:43,500 [salt.state       ][INFO    ][2043] Running state [msg01] at time 05:40:43.499907
2017-12-09 05:40:43,500 [salt.state       ][INFO    ][2043] Executing state host.present for msg01
2017-12-09 05:40:43,501 [salt.state       ][INFO    ][2043] {'host': 'msg01'}
2017-12-09 05:40:43,501 [salt.state       ][INFO    ][2043] Completed state [msg01] at time 05:40:43.501212 duration_in_ms=1.305
2017-12-09 05:40:43,501 [salt.state       ][INFO    ][2043] Running state [msg] at time 05:40:43.501420
2017-12-09 05:40:43,502 [salt.state       ][INFO    ][2043] Executing state host.present for msg
2017-12-09 05:40:43,503 [salt.state       ][INFO    ][2043] {'host': 'msg'}
2017-12-09 05:40:43,503 [salt.state       ][INFO    ][2043] Completed state [msg] at time 05:40:43.502699 duration_in_ms=1.279
2017-12-09 05:40:43,503 [salt.state       ][INFO    ][2043] Running state [msg.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.502911
2017-12-09 05:40:43,503 [salt.state       ][INFO    ][2043] Executing state host.present for msg.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,504 [salt.state       ][INFO    ][2043] {'host': 'msg.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,504 [salt.state       ][INFO    ][2043] Completed state [msg.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.504205 duration_in_ms=1.294
2017-12-09 05:40:43,504 [salt.state       ][INFO    ][2043] Running state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.504418
2017-12-09 05:40:43,505 [salt.state       ][INFO    ][2043] Executing state host.present for cfg01.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,505 [salt.state       ][INFO    ][2043] Host cfg01.baremetal-mcp-ocata-odl-ha.local (192.168.10.100) already present
2017-12-09 05:40:43,505 [salt.state       ][INFO    ][2043] Completed state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.505149 duration_in_ms=0.731
2017-12-09 05:40:43,505 [salt.state       ][INFO    ][2043] Running state [cfg01] at time 05:40:43.505335
2017-12-09 05:40:43,506 [salt.state       ][INFO    ][2043] Executing state host.present for cfg01
2017-12-09 05:40:43,506 [salt.state       ][INFO    ][2043] Host cfg01 (192.168.10.100) already present
2017-12-09 05:40:43,506 [salt.state       ][INFO    ][2043] Completed state [cfg01] at time 05:40:43.506030 duration_in_ms=0.695
2017-12-09 05:40:43,506 [salt.state       ][INFO    ][2043] Running state [cmp002] at time 05:40:43.506218
2017-12-09 05:40:43,506 [salt.state       ][INFO    ][2043] Executing state host.present for cmp002
2017-12-09 05:40:43,507 [salt.state       ][INFO    ][2043] {'host': 'cmp002'}
2017-12-09 05:40:43,507 [salt.state       ][INFO    ][2043] Completed state [cmp002] at time 05:40:43.507392 duration_in_ms=1.174
2017-12-09 05:40:43,508 [salt.state       ][INFO    ][2043] Running state [cmp002.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.507587
2017-12-09 05:40:43,508 [salt.state       ][INFO    ][2043] Executing state host.present for cmp002.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,509 [salt.state       ][INFO    ][2043] {'host': 'cmp002.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,509 [salt.state       ][INFO    ][2043] Completed state [cmp002.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.508768 duration_in_ms=1.181
2017-12-09 05:40:43,509 [salt.state       ][INFO    ][2043] Running state [cmp001] at time 05:40:43.508964
2017-12-09 05:40:43,509 [salt.state       ][INFO    ][2043] Executing state host.present for cmp001
2017-12-09 05:40:43,510 [salt.state       ][INFO    ][2043] {'host': 'cmp001'}
2017-12-09 05:40:43,510 [salt.state       ][INFO    ][2043] Completed state [cmp001] at time 05:40:43.510221 duration_in_ms=1.257
2017-12-09 05:40:43,510 [salt.state       ][INFO    ][2043] Running state [cmp001.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.510426
2017-12-09 05:40:43,511 [salt.state       ][INFO    ][2043] Executing state host.present for cmp001.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,511 [salt.state       ][INFO    ][2043] {'host': 'cmp001.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,512 [salt.state       ][INFO    ][2043] Completed state [cmp001.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.511642 duration_in_ms=1.216
2017-12-09 05:40:43,512 [salt.state       ][INFO    ][2043] Running state [dbs01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.511853
2017-12-09 05:40:43,512 [salt.state       ][INFO    ][2043] Executing state host.present for dbs01.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,513 [salt.state       ][INFO    ][2043] {'host': 'dbs01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,513 [salt.state       ][INFO    ][2043] Completed state [dbs01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.513145 duration_in_ms=1.292
2017-12-09 05:40:43,513 [salt.state       ][INFO    ][2043] Running state [dbs01] at time 05:40:43.513354
2017-12-09 05:40:43,514 [salt.state       ][INFO    ][2043] Executing state host.present for dbs01
2017-12-09 05:40:43,515 [salt.state       ][INFO    ][2043] {'host': 'dbs01'}
2017-12-09 05:40:43,515 [salt.state       ][INFO    ][2043] Completed state [dbs01] at time 05:40:43.514656 duration_in_ms=1.303
2017-12-09 05:40:43,515 [salt.state       ][INFO    ][2043] Running state [dbs02.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.514880
2017-12-09 05:40:43,515 [salt.state       ][INFO    ][2043] Executing state host.present for dbs02.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,516 [salt.state       ][INFO    ][2043] {'host': 'dbs02.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,516 [salt.state       ][INFO    ][2043] Completed state [dbs02.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.516158 duration_in_ms=1.278
2017-12-09 05:40:43,516 [salt.state       ][INFO    ][2043] Running state [dbs02] at time 05:40:43.516366
2017-12-09 05:40:43,517 [salt.state       ][INFO    ][2043] Executing state host.present for dbs02
2017-12-09 05:40:43,518 [salt.state       ][INFO    ][2043] {'host': 'dbs02'}
2017-12-09 05:40:43,518 [salt.state       ][INFO    ][2043] Completed state [dbs02] at time 05:40:43.517689 duration_in_ms=1.323
2017-12-09 05:40:43,518 [salt.state       ][INFO    ][2043] Running state [dbs03.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.517905
2017-12-09 05:40:43,518 [salt.state       ][INFO    ][2043] Executing state host.present for dbs03.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,519 [salt.state       ][INFO    ][2043] {'host': 'dbs03.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,519 [salt.state       ][INFO    ][2043] Completed state [dbs03.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.519387 duration_in_ms=1.482
2017-12-09 05:40:43,520 [salt.state       ][INFO    ][2043] Running state [dbs03] at time 05:40:43.519591
2017-12-09 05:40:43,520 [salt.state       ][INFO    ][2043] Executing state host.present for dbs03
2017-12-09 05:40:43,521 [salt.state       ][INFO    ][2043] {'host': 'dbs03'}
2017-12-09 05:40:43,521 [salt.state       ][INFO    ][2043] Completed state [dbs03] at time 05:40:43.520916 duration_in_ms=1.325
2017-12-09 05:40:43,521 [salt.state       ][INFO    ][2043] Running state [odl01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.521116
2017-12-09 05:40:43,521 [salt.state       ][INFO    ][2043] Executing state host.present for odl01.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,522 [salt.state       ][INFO    ][2043] {'host': 'odl01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,522 [salt.state       ][INFO    ][2043] Completed state [odl01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.522426 duration_in_ms=1.31
2017-12-09 05:40:43,523 [salt.state       ][INFO    ][2043] Running state [odl01] at time 05:40:43.522633
2017-12-09 05:40:43,523 [salt.state       ][INFO    ][2043] Executing state host.present for odl01
2017-12-09 05:40:43,524 [salt.state       ][INFO    ][2043] {'host': 'odl01'}
2017-12-09 05:40:43,524 [salt.state       ][INFO    ][2043] Completed state [odl01] at time 05:40:43.523916 duration_in_ms=1.283
2017-12-09 05:40:43,524 [salt.state       ][INFO    ][2043] Running state [mas01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.524134
2017-12-09 05:40:43,524 [salt.state       ][INFO    ][2043] Executing state host.present for mas01.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,525 [salt.state       ][INFO    ][2043] {'host': 'mas01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,526 [salt.state       ][INFO    ][2043] Completed state [mas01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.525469 duration_in_ms=1.334
2017-12-09 05:40:43,526 [salt.state       ][INFO    ][2043] Running state [mas01] at time 05:40:43.525706
2017-12-09 05:40:43,526 [salt.state       ][INFO    ][2043] Executing state host.present for mas01
2017-12-09 05:40:43,527 [salt.state       ][INFO    ][2043] {'host': 'mas01'}
2017-12-09 05:40:43,527 [salt.state       ][INFO    ][2043] Completed state [mas01] at time 05:40:43.527031 duration_in_ms=1.325
2017-12-09 05:40:43,527 [salt.state       ][INFO    ][2043] Running state [ctl02.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.527244
2017-12-09 05:40:43,527 [salt.state       ][INFO    ][2043] Executing state host.present for ctl02.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,528 [salt.state       ][INFO    ][2043] {'host': 'ctl02.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,529 [salt.state       ][INFO    ][2043] Completed state [ctl02.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.528547 duration_in_ms=1.303
2017-12-09 05:40:43,529 [salt.state       ][INFO    ][2043] Running state [ctl02] at time 05:40:43.528756
2017-12-09 05:40:43,529 [salt.state       ][INFO    ][2043] Executing state host.present for ctl02
2017-12-09 05:40:43,530 [salt.state       ][INFO    ][2043] {'host': 'ctl02'}
2017-12-09 05:40:43,530 [salt.state       ][INFO    ][2043] Completed state [ctl02] at time 05:40:43.530091 duration_in_ms=1.335
2017-12-09 05:40:43,530 [salt.state       ][INFO    ][2043] Running state [ctl03.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.530299
2017-12-09 05:40:43,531 [salt.state       ][INFO    ][2043] Executing state host.present for ctl03.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,532 [salt.state       ][INFO    ][2043] {'host': 'ctl03.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,532 [salt.state       ][INFO    ][2043] Completed state [ctl03.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.531664 duration_in_ms=1.365
2017-12-09 05:40:43,532 [salt.state       ][INFO    ][2043] Running state [ctl03] at time 05:40:43.531865
2017-12-09 05:40:43,532 [salt.state       ][INFO    ][2043] Executing state host.present for ctl03
2017-12-09 05:40:43,533 [salt.state       ][INFO    ][2043] {'host': 'ctl03'}
2017-12-09 05:40:43,533 [salt.state       ][INFO    ][2043] Completed state [ctl03] at time 05:40:43.533315 duration_in_ms=1.45
2017-12-09 05:40:43,534 [salt.state       ][INFO    ][2043] Running state [ctl01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.533524
2017-12-09 05:40:43,534 [salt.state       ][INFO    ][2043] Executing state host.present for ctl01.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,535 [salt.state       ][INFO    ][2043] {'host': 'ctl01.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,535 [salt.state       ][INFO    ][2043] Completed state [ctl01.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.534961 duration_in_ms=1.436
2017-12-09 05:40:43,535 [salt.state       ][INFO    ][2043] Running state [ctl01] at time 05:40:43.535185
2017-12-09 05:40:43,535 [salt.state       ][INFO    ][2043] Executing state host.present for ctl01
2017-12-09 05:40:43,536 [salt.state       ][INFO    ][2043] {'host': 'ctl01'}
2017-12-09 05:40:43,537 [salt.state       ][INFO    ][2043] Completed state [ctl01] at time 05:40:43.536511 duration_in_ms=1.326
2017-12-09 05:40:43,537 [salt.state       ][INFO    ][2043] Running state [ctl] at time 05:40:43.536722
2017-12-09 05:40:43,537 [salt.state       ][INFO    ][2043] Executing state host.present for ctl
2017-12-09 05:40:43,538 [salt.state       ][INFO    ][2043] {'host': 'ctl'}
2017-12-09 05:40:43,538 [salt.state       ][INFO    ][2043] Completed state [ctl] at time 05:40:43.538075 duration_in_ms=1.353
2017-12-09 05:40:43,538 [salt.state       ][INFO    ][2043] Running state [ctl.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.538280
2017-12-09 05:40:43,539 [salt.state       ][INFO    ][2043] Executing state host.present for ctl.baremetal-mcp-ocata-odl-ha.local
2017-12-09 05:40:43,540 [salt.state       ][INFO    ][2043] {'host': 'ctl.baremetal-mcp-ocata-odl-ha.local'}
2017-12-09 05:40:43,540 [salt.state       ][INFO    ][2043] Completed state [ctl.baremetal-mcp-ocata-odl-ha.local] at time 05:40:43.539685 duration_in_ms=1.404
2017-12-09 05:40:43,543 [salt.state       ][INFO    ][2043] Running state [ens3] at time 05:40:43.543029
2017-12-09 05:40:43,543 [salt.state       ][INFO    ][2043] Executing state network.managed for ens3
2017-12-09 05:40:43,634 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['ifdown', 'ens3'] in directory '/root'
2017-12-09 05:40:43,655 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['ifup', 'ens3'] in directory '/root'
2017-12-09 05:40:43,717 [salt.state       ][INFO    ][2043] {'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-09 05:40:43,717 [salt.state       ][INFO    ][2043] Completed state [ens3] at time 05:40:43.717113 duration_in_ms=174.083
2017-12-09 05:40:43,717 [salt.state       ][INFO    ][2043] Running state [/etc/profile.d/proxy.sh] at time 05:40:43.717407
2017-12-09 05:40:43,718 [salt.state       ][INFO    ][2043] Executing state file.absent for /etc/profile.d/proxy.sh
2017-12-09 05:40:43,718 [salt.state       ][INFO    ][2043] File /etc/profile.d/proxy.sh is not present
2017-12-09 05:40:43,718 [salt.state       ][INFO    ][2043] Completed state [/etc/profile.d/proxy.sh] at time 05:40:43.718264 duration_in_ms=0.857
2017-12-09 05:40:43,719 [salt.state       ][INFO    ][2043] Running state [/etc/apt/apt.conf.d/95proxies] at time 05:40:43.718503
2017-12-09 05:40:43,719 [salt.state       ][INFO    ][2043] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2017-12-09 05:40:43,719 [salt.state       ][INFO    ][2043] File /etc/apt/apt.conf.d/95proxies is not present
2017-12-09 05:40:43,719 [salt.state       ][INFO    ][2043] Completed state [/etc/apt/apt.conf.d/95proxies] at time 05:40:43.719113 duration_in_ms=0.61
2017-12-09 05:40:43,725 [salt.state       ][INFO    ][2043] Running state [ntp] at time 05:40:43.725135
2017-12-09 05:40:43,725 [salt.state       ][INFO    ][2043] Executing state pkg.installed for ntp
2017-12-09 05:40:43,898 [salt.loaded.int.module.cmdmod][INFO    ][2043] 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-09 05:40:46,895 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-09 05:40:46,917 [salt.state       ][INFO    ][2043] 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-09 05:40:46,927 [salt.state       ][INFO    ][2043] Loading fresh modules for state activity
2017-12-09 05:40:46,947 [salt.state       ][INFO    ][2043] Completed state [ntp] at time 05:40:46.946483 duration_in_ms=3221.347
2017-12-09 05:40:46,949 [salt.state       ][INFO    ][2043] Running state [/etc/ntp.conf] at time 05:40:46.949140
2017-12-09 05:40:46,950 [salt.state       ][INFO    ][2043] Executing state file.managed for /etc/ntp.conf
2017-12-09 05:40:46,969 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2017-12-09 05:40:46,994 [salt.fileclient  ][INFO    ][2043] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-09 05:40:47,005 [salt.state       ][INFO    ][2043] 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-09 05:40:47,006 [salt.state       ][INFO    ][2043] Completed state [/etc/ntp.conf] at time 05:40:47.006252 duration_in_ms=57.112
2017-12-09 05:40:47,080 [salt.state       ][INFO    ][2043] Running state [ntp] at time 05:40:47.080324
2017-12-09 05:40:47,081 [salt.state       ][INFO    ][2043] Executing state service.running for ntp
2017-12-09 05:40:47,082 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2017-12-09 05:40:47,093 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2017-12-09 05:40:47,102 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2017-12-09 05:40:47,111 [salt.state       ][INFO    ][2043] The service ntp is already running
2017-12-09 05:40:47,112 [salt.state       ][INFO    ][2043] Completed state [ntp] at time 05:40:47.111470 duration_in_ms=31.159
2017-12-09 05:40:47,112 [salt.state       ][INFO    ][2043] Running state [ntp] at time 05:40:47.111755
2017-12-09 05:40:47,112 [salt.state       ][INFO    ][2043] Executing state service.mod_watch for ntp
2017-12-09 05:40:47,113 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2017-12-09 05:40:47,121 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2017-12-09 05:40:47,131 [salt.loaded.int.module.cmdmod][INFO    ][2043] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2017-12-09 05:40:47,187 [salt.state       ][INFO    ][2043] {'ntp': True}
2017-12-09 05:40:47,187 [salt.state       ][INFO    ][2043] Completed state [ntp] at time 05:40:47.187390 duration_in_ms=75.634
2017-12-09 05:40:47,191 [salt.minion      ][INFO    ][2043] Returning information for job: 20171209054008664522
2017-12-09 05:41:08,852 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20171209054108843113
2017-12-09 05:41:08,871 [salt.minion      ][INFO    ][5961] Starting a new job with PID 5961
2017-12-09 05:41:08,883 [salt.minion      ][INFO    ][5961] Returning information for job: 20171209054108843113
2017-12-09 05:46:22,377 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command state.sls with jid 20171209054622369793
2017-12-09 05:46:22,388 [salt.minion      ][INFO    ][6185] Starting a new job with PID 6185
2017-12-09 05:46:24,607 [salt.state       ][INFO    ][6185] Loading fresh modules for state activity
2017-12-09 05:46:24,654 [salt.fileclient  ][INFO    ][6185] Fetching file from saltenv 'base', ** done ** 'opendaylight/init.sls'
2017-12-09 05:46:24,715 [salt.fileclient  ][INFO    ][6185] Fetching file from saltenv 'base', ** done ** 'opendaylight/server.sls'
2017-12-09 05:46:24,747 [salt.fileclient  ][INFO    ][6185] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
2017-12-09 05:46:24,776 [salt.state       ][INFO    ][6185] Running state [opendaylight_repo] at time 05:46:24.776137
2017-12-09 05:46:24,776 [salt.state       ][INFO    ][6185] Executing state pkgrepo.managed for opendaylight_repo
2017-12-09 05:46:24,846 [salt.loaded.int.module.cmdmod][INFO    ][6185] Executing command ['apt-add-repository', '-y', 'ppa:odl-team/nitrogen'] in directory '/root'
2017-12-09 05:46:25,672 [salt.loaded.int.module.cmdmod][INFO    ][6185] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-09 05:46:27,634 [salt.state       ][INFO    ][6185] {'repo': 'ppa:odl-team/nitrogen'}
2017-12-09 05:46:27,634 [salt.state       ][INFO    ][6185] Completed state [opendaylight_repo] at time 05:46:27.633935 duration_in_ms=2857.797
2017-12-09 05:46:27,878 [salt.state       ][INFO    ][6185] Running state [opendaylight] at time 05:46:27.877577
2017-12-09 05:46:27,878 [salt.state       ][INFO    ][6185] Executing state pkg.installed for opendaylight
2017-12-09 05:46:27,878 [salt.loaded.int.module.cmdmod][INFO    ][6185] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-09 05:46:28,375 [salt.loaded.int.module.cmdmod][INFO    ][6185] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-09 05:46:30,192 [salt.loaded.int.module.cmdmod][INFO    ][6185] 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-09 05:46:32,485 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054632475202
2017-12-09 05:46:32,496 [salt.minion      ][INFO    ][7079] Starting a new job with PID 7079
2017-12-09 05:46:32,506 [salt.minion      ][INFO    ][7079] Returning information for job: 20171209054632475202
2017-12-09 05:46:42,695 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054642681592
2017-12-09 05:46:42,707 [salt.minion      ][INFO    ][7089] Starting a new job with PID 7089
2017-12-09 05:46:42,717 [salt.minion      ][INFO    ][7089] Returning information for job: 20171209054642681592
2017-12-09 05:46:52,906 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054652895901
2017-12-09 05:46:52,917 [salt.minion      ][INFO    ][7094] Starting a new job with PID 7094
2017-12-09 05:46:52,926 [salt.minion      ][INFO    ][7094] Returning information for job: 20171209054652895901
2017-12-09 05:47:03,108 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054703094332
2017-12-09 05:47:03,123 [salt.minion      ][INFO    ][7099] Starting a new job with PID 7099
2017-12-09 05:47:03,133 [salt.minion      ][INFO    ][7099] Returning information for job: 20171209054703094332
2017-12-09 05:47:13,327 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054713310832
2017-12-09 05:47:13,338 [salt.minion      ][INFO    ][7109] Starting a new job with PID 7109
2017-12-09 05:47:13,347 [salt.minion      ][INFO    ][7109] Returning information for job: 20171209054713310832
2017-12-09 05:47:23,530 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054723519020
2017-12-09 05:47:23,542 [salt.minion      ][INFO    ][7114] Starting a new job with PID 7114
2017-12-09 05:47:23,552 [salt.minion      ][INFO    ][7114] Returning information for job: 20171209054723519020
2017-12-09 05:47:33,756 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054733742264
2017-12-09 05:47:33,768 [salt.minion      ][INFO    ][7124] Starting a new job with PID 7124
2017-12-09 05:47:33,776 [salt.minion      ][INFO    ][7124] Returning information for job: 20171209054733742264
2017-12-09 05:47:43,819 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054743803302
2017-12-09 05:47:43,831 [salt.minion      ][INFO    ][7129] Starting a new job with PID 7129
2017-12-09 05:47:43,841 [salt.minion      ][INFO    ][7129] Returning information for job: 20171209054743803302
2017-12-09 05:47:54,047 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054754032413
2017-12-09 05:47:54,058 [salt.minion      ][INFO    ][7134] Starting a new job with PID 7134
2017-12-09 05:47:54,067 [salt.minion      ][INFO    ][7134] Returning information for job: 20171209054754032413
2017-12-09 05:48:04,263 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054804255130
2017-12-09 05:48:04,274 [salt.minion      ][INFO    ][7144] Starting a new job with PID 7144
2017-12-09 05:48:04,283 [salt.minion      ][INFO    ][7144] Returning information for job: 20171209054804255130
2017-12-09 05:48:14,483 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054814475467
2017-12-09 05:48:14,495 [salt.minion      ][INFO    ][7232] Starting a new job with PID 7232
2017-12-09 05:48:14,504 [salt.minion      ][INFO    ][7232] Returning information for job: 20171209054814475467
2017-12-09 05:48:24,706 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054824696064
2017-12-09 05:48:24,716 [salt.minion      ][INFO    ][7309] Starting a new job with PID 7309
2017-12-09 05:48:24,726 [salt.minion      ][INFO    ][7309] Returning information for job: 20171209054824696064
2017-12-09 05:48:34,933 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054834921712
2017-12-09 05:48:34,945 [salt.minion      ][INFO    ][7314] Starting a new job with PID 7314
2017-12-09 05:48:34,955 [salt.minion      ][INFO    ][7314] Returning information for job: 20171209054834921712
2017-12-09 05:48:45,165 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054845155086
2017-12-09 05:48:45,176 [salt.minion      ][INFO    ][7324] Starting a new job with PID 7324
2017-12-09 05:48:45,186 [salt.minion      ][INFO    ][7324] Returning information for job: 20171209054845155086
2017-12-09 05:48:55,402 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054855389353
2017-12-09 05:48:55,413 [salt.minion      ][INFO    ][7329] Starting a new job with PID 7329
2017-12-09 05:48:55,422 [salt.minion      ][INFO    ][7329] Returning information for job: 20171209054855389353
2017-12-09 05:49:05,636 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054905624966
2017-12-09 05:49:05,646 [salt.minion      ][INFO    ][7339] Starting a new job with PID 7339
2017-12-09 05:49:05,654 [salt.minion      ][INFO    ][7339] Returning information for job: 20171209054905624966
2017-12-09 05:49:15,865 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054915857326
2017-12-09 05:49:15,876 [salt.minion      ][INFO    ][7344] Starting a new job with PID 7344
2017-12-09 05:49:15,885 [salt.minion      ][INFO    ][7344] Returning information for job: 20171209054915857326
2017-12-09 05:49:26,097 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054926085214
2017-12-09 05:49:26,107 [salt.minion      ][INFO    ][7354] Starting a new job with PID 7354
2017-12-09 05:49:26,115 [salt.minion      ][INFO    ][7354] Returning information for job: 20171209054926085214
2017-12-09 05:49:36,118 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054936109401
2017-12-09 05:49:36,129 [salt.minion      ][INFO    ][7359] Starting a new job with PID 7359
2017-12-09 05:49:36,139 [salt.minion      ][INFO    ][7359] Returning information for job: 20171209054936109401
2017-12-09 05:49:46,149 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054946134904
2017-12-09 05:49:46,159 [salt.minion      ][INFO    ][7364] Starting a new job with PID 7364
2017-12-09 05:49:46,170 [salt.minion      ][INFO    ][7364] Returning information for job: 20171209054946134904
2017-12-09 05:49:56,175 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209054956167989
2017-12-09 05:49:56,186 [salt.minion      ][INFO    ][7374] Starting a new job with PID 7374
2017-12-09 05:49:56,197 [salt.minion      ][INFO    ][7374] Returning information for job: 20171209054956167989
2017-12-09 05:50:06,215 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209055006205042
2017-12-09 05:50:06,227 [salt.minion      ][INFO    ][7379] Starting a new job with PID 7379
2017-12-09 05:50:06,238 [salt.minion      ][INFO    ][7379] Returning information for job: 20171209055006205042
2017-12-09 05:50:16,260 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209055016254086
2017-12-09 05:50:16,272 [salt.minion      ][INFO    ][7389] Starting a new job with PID 7389
2017-12-09 05:50:16,283 [salt.minion      ][INFO    ][7389] Returning information for job: 20171209055016254086
2017-12-09 05:50:26,418 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209055026407735
2017-12-09 05:50:26,430 [salt.minion      ][INFO    ][7394] Starting a new job with PID 7394
2017-12-09 05:50:26,441 [salt.minion      ][INFO    ][7394] Returning information for job: 20171209055026407735
2017-12-09 05:50:36,477 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209055036464869
2017-12-09 05:50:36,489 [salt.minion      ][INFO    ][7399] Starting a new job with PID 7399
2017-12-09 05:50:36,499 [salt.minion      ][INFO    ][7399] Returning information for job: 20171209055036464869
2017-12-09 05:50:46,530 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209055046519610
2017-12-09 05:50:46,542 [salt.minion      ][INFO    ][7405] Starting a new job with PID 7405
2017-12-09 05:50:46,553 [salt.minion      ][INFO    ][7405] Returning information for job: 20171209055046519610
2017-12-09 05:50:56,586 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209055056575736
2017-12-09 05:50:56,598 [salt.minion      ][INFO    ][7415] Starting a new job with PID 7415
2017-12-09 05:50:56,608 [salt.minion      ][INFO    ][7415] Returning information for job: 20171209055056575736
2017-12-09 05:51:06,645 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209055106638782
2017-12-09 05:51:06,655 [salt.minion      ][INFO    ][7420] Starting a new job with PID 7420
2017-12-09 05:51:06,665 [salt.minion      ][INFO    ][7420] Returning information for job: 20171209055106638782
2017-12-09 05:51:16,709 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209055116696056
2017-12-09 05:51:16,720 [salt.minion      ][INFO    ][7430] Starting a new job with PID 7430
2017-12-09 05:51:16,731 [salt.minion      ][INFO    ][7430] Returning information for job: 20171209055116696056
2017-12-09 05:51:26,778 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209055126771148
2017-12-09 05:51:26,789 [salt.minion      ][INFO    ][7435] Starting a new job with PID 7435
2017-12-09 05:51:26,800 [salt.minion      ][INFO    ][7435] Returning information for job: 20171209055126771148
2017-12-09 05:51:36,850 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209055136838994
2017-12-09 05:51:36,861 [salt.minion      ][INFO    ][7445] Starting a new job with PID 7445
2017-12-09 05:51:36,872 [salt.minion      ][INFO    ][7445] Returning information for job: 20171209055136838994
2017-12-09 05:51:46,915 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209055146907412
2017-12-09 05:51:46,926 [salt.minion      ][INFO    ][7665] Starting a new job with PID 7665
2017-12-09 05:51:46,937 [salt.minion      ][INFO    ][7665] Returning information for job: 20171209055146907412
2017-12-09 05:51:56,996 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209055156986712
2017-12-09 05:51:57,008 [salt.minion      ][INFO    ][7670] Starting a new job with PID 7670
2017-12-09 05:51:57,020 [salt.minion      ][INFO    ][7670] Returning information for job: 20171209055156986712
2017-12-09 05:52:07,090 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command saltutil.find_job with jid 20171209055207078886
2017-12-09 05:52:07,102 [salt.minion      ][INFO    ][10333] Starting a new job with PID 10333
2017-12-09 05:52:07,115 [salt.minion      ][INFO    ][10333] Returning information for job: 20171209055207078886
2017-12-09 05:52:07,292 [salt.loaded.int.module.cmdmod][INFO    ][6185] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-09 05:52:07,315 [salt.state       ][INFO    ][6185] 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-09 05:52:07,326 [salt.state       ][INFO    ][6185] Loading fresh modules for state activity
2017-12-09 05:52:07,342 [salt.state       ][INFO    ][6185] Completed state [opendaylight] at time 05:52:07.341674 duration_in_ms=339464.096
2017-12-09 05:52:07,447 [salt.state       ][INFO    ][6185] Running state [/opt/opendaylight/etc/jetty.xml] at time 05:52:07.446880
2017-12-09 05:52:07,447 [salt.state       ][INFO    ][6185] Executing state file.managed for /opt/opendaylight/etc/jetty.xml
2017-12-09 05:52:07,489 [salt.fileclient  ][INFO    ][6185] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/jetty.xml'
2017-12-09 05:52:07,518 [salt.fileclient  ][INFO    ][6185] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
2017-12-09 05:52:07,529 [salt.state       ][INFO    ][6185] 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-09 05:52:07,530 [salt.state       ][INFO    ][6185] Completed state [/opt/opendaylight/etc/jetty.xml] at time 05:52:07.529484 duration_in_ms=82.604
2017-12-09 05:52:07,530 [salt.state       ][INFO    ][6185] Running state [/opt/opendaylight/bin/setenv] at time 05:52:07.529729
2017-12-09 05:52:07,530 [salt.state       ][INFO    ][6185] Executing state file.managed for /opt/opendaylight/bin/setenv
2017-12-09 05:52:07,554 [salt.fileclient  ][INFO    ][6185] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/setenv.shell'
2017-12-09 05:52:07,579 [salt.fileclient  ][INFO    ][6185] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
2017-12-09 05:52:07,588 [salt.state       ][INFO    ][6185] 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-09 05:52:07,588 [salt.state       ][INFO    ][6185] Completed state [/opt/opendaylight/bin/setenv] at time 05:52:07.587690 duration_in_ms=57.961
2017-12-09 05:52:07,590 [salt.state       ][INFO    ][6185] Running state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 05:52:07.590271
2017-12-09 05:52:07,590 [salt.state       ][INFO    ][6185] Executing state ini.options_present for /opt/opendaylight/etc/org.apache.karaf.features.cfg
2017-12-09 05:52:07,608 [salt.state       ][INFO    ][6185] {'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-09 05:52:07,608 [salt.state       ][INFO    ][6185] Completed state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 05:52:07.607699 duration_in_ms=17.428
2017-12-09 05:52:07,608 [salt.state       ][INFO    ][6185] Running state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 05:52:07.607978
2017-12-09 05:52:07,608 [salt.state       ][INFO    ][6185] Executing state ini.options_present for /opt/opendaylight/etc/org.ops4j.pax.web.cfg
2017-12-09 05:52:07,609 [salt.state       ][INFO    ][6185] {'org.ops4j.pax.web.listening.addresses': {'after': '192.168.10.111', 'before': None}}
2017-12-09 05:52:07,609 [salt.state       ][INFO    ][6185] Completed state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 05:52:07.608929 duration_in_ms=0.951
2017-12-09 05:52:07,609 [salt.state       ][INFO    ][6185] Running state [/opt/opendaylight/etc/custom.properties] at time 05:52:07.609209
2017-12-09 05:52:07,609 [salt.state       ][INFO    ][6185] Executing state ini.options_present for /opt/opendaylight/etc/custom.properties
2017-12-09 05:52:07,633 [salt.state       ][INFO    ][6185] {'ovsdb.l3.fwd.enabled': {'after': 'yes', 'before': None}, 'ovsdb.of.version': {'after': 1.3, 'before': None}}
2017-12-09 05:52:07,633 [salt.state       ][INFO    ][6185] Completed state [/opt/opendaylight/etc/custom.properties] at time 05:52:07.633230 duration_in_ms=24.019
2017-12-09 05:52:07,634 [salt.state       ][INFO    ][6185] Running state [opendaylight] at time 05:52:07.633717
2017-12-09 05:52:07,634 [salt.state       ][INFO    ][6185] Executing state service.running for opendaylight
2017-12-09 05:52:07,636 [salt.loaded.int.module.cmdmod][INFO    ][6185] Executing command ['systemctl', 'status', 'opendaylight.service', '-n', '0'] in directory '/root'
2017-12-09 05:52:07,647 [salt.loaded.int.module.cmdmod][INFO    ][6185] Executing command ['systemctl', 'is-active', 'opendaylight.service'] in directory '/root'
2017-12-09 05:52:07,656 [salt.loaded.int.module.cmdmod][INFO    ][6185] Executing command ['systemctl', 'is-enabled', 'opendaylight.service'] in directory '/root'
2017-12-09 05:52:07,665 [salt.state       ][INFO    ][6185] The service opendaylight is already running
2017-12-09 05:52:07,666 [salt.state       ][INFO    ][6185] Completed state [opendaylight] at time 05:52:07.665668 duration_in_ms=31.951
2017-12-09 05:52:07,666 [salt.state       ][INFO    ][6185] Running state [opendaylight] at time 05:52:07.665863
2017-12-09 05:52:07,666 [salt.state       ][INFO    ][6185] Executing state service.mod_watch for opendaylight
2017-12-09 05:52:07,667 [salt.loaded.int.module.cmdmod][INFO    ][6185] Executing command ['systemctl', 'is-active', 'opendaylight.service'] in directory '/root'
2017-12-09 05:52:07,682 [salt.loaded.int.module.cmdmod][INFO    ][6185] Executing command ['systemctl', 'is-enabled', 'opendaylight.service'] in directory '/root'
2017-12-09 05:52:07,691 [salt.loaded.int.module.cmdmod][INFO    ][6185] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'opendaylight.service'] in directory '/root'
2017-12-09 05:52:08,089 [salt.state       ][INFO    ][6185] {'opendaylight': True}
2017-12-09 05:52:08,090 [salt.state       ][INFO    ][6185] Completed state [opendaylight] at time 05:52:08.089754 duration_in_ms=423.891
2017-12-09 05:52:08,091 [salt.minion      ][INFO    ][6185] Returning information for job: 20171209054622369793
2017-12-09 06:40:03,853 [salt.utils.schedule][INFO    ][1947] Running scheduled job: __mine_interval
2017-12-09 07:01:25,921 [salt.minion      ][INFO    ][1947] User sudo_ubuntu Executing command cp.push_dir with jid 20171209070125911921
2017-12-09 07:01:25,937 [salt.minion      ][INFO    ][14944] Starting a new job with PID 14944
