2019-05-18 16:28:39,562 [salt.utils       :831 ][ERROR   ][1628] DNS lookup or connection check of 'salt' failed.
2019-05-18 16:28:39,562 [salt.minion      :152 ][ERROR   ][1628] Master hostname: 'salt' not found or not responsive. Retrying in 30 seconds
2019-05-18 16:28:41,850 [salt.utils.parsers:1051][WARNING ][1628] Minion received a SIGTERM. Exiting.
2019-05-18 16:29:24,897 [salt.minion      :870 ][ERROR   ][1810] Error while bringing up minion for multi-master. Is master at 192.168.11.2 responding?
2019-05-18 16:34:24,493 [salt.utils.decorators:613 ][WARNING ][2056] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-18 16:34:38,928 [salt.loaded.int.states.file:2298][WARNING ][2056] State for file: /boot/grub/grub.cfg - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-05-18 16:34:49,108 [salt.utils.decorators:613 ][WARNING ][2056] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-18 16:34:49,216 [salt.loaded.int.states.file:2298][WARNING ][2056] State for file: /etc/shadow - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-05-18 16:34:49,219 [salt.loaded.int.states.file:2298][WARNING ][2056] State for file: /etc/gshadow - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-05-18 16:34:49,221 [salt.loaded.int.states.file:2298][WARNING ][2056] State for file: /etc/group- - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-05-18 16:34:49,223 [salt.loaded.int.states.file:2298][WARNING ][2056] State for file: /etc/group - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-05-18 16:34:49,224 [salt.loaded.int.states.file:2298][WARNING ][2056] State for file: /etc/passwd- - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-05-18 16:34:49,225 [salt.loaded.int.states.file:2298][WARNING ][2056] State for file: /etc/passwd - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-05-18 16:34:49,226 [salt.loaded.int.states.file:2298][WARNING ][2056] State for file: /etc/gshadow- - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-05-18 16:34:49,227 [salt.loaded.int.states.file:2298][WARNING ][2056] State for file: /etc/shadow- - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-05-18 16:34:57,945 [salt.loaded.int.module.debian_ip:1964][WARNING ][2056] The network state sls is requiring a reboot of the system to properly apply network configuration.
2019-05-18 16:34:59,189 [salt.loaded.int.module.cmdmod:730 ][ERROR   ][2056] Command '['umount', '/dev/shm']' failed with return code: 32
2019-05-18 16:34:59,189 [salt.loaded.int.module.cmdmod:734 ][ERROR   ][2056] stderr: umount: /dev/shm: target is busy
        (In some cases useful info about processes that
         use the device is found by lsof(8) or fuser(1).)
2019-05-18 16:34:59,190 [salt.loaded.int.module.cmdmod:736 ][ERROR   ][2056] retcode: 32
2019-05-18 16:35:01,393 [salt.utils.parsers:1051][WARNING ][1810] Minion received a SIGTERM. Exiting.
2019-05-18 16:36:21,042 [salt.utils.decorators:613 ][WARNING ][3086] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-05-18 16:36:23,961 [salt.loaded.int.states.file:2298][WARNING ][3086] State for file: /etc/kubernetes/ssl/ca-kubernetes.crt - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-05-18 16:36:27,217 [salt.loaded.int.states.file:2298][WARNING ][3086] State for file: /var/lib/etcd/ca.pem - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-05-18 16:36:41,703 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4912] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2019-05-18 16:36:41,727 [salt.loaded.int.module.cmdmod:395 ][INFO    ][4912] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2019-05-18 16:36:41,740 [salt.utils.parsers:1051][WARNING ][2471] Minion received a SIGTERM. Exiting.
2019-05-18 16:36:42,594 [salt.cli.daemons :293 ][INFO    ][4965] Setting up the Salt Minion "cmp002.mcp-k8s-calico-noha.local"
2019-05-18 16:36:42,699 [salt.cli.daemons :82  ][INFO    ][4965] Starting up the Salt Minion
2019-05-18 16:36:42,699 [salt.utils.event :1017][INFO    ][4965] Starting pull socket on /var/run/salt/minion/minion_event_d677558cdd_pull.ipc
2019-05-18 16:36:43,271 [salt.minion      :976 ][INFO    ][4965] Creating minion process manager
2019-05-18 16:36:44,639 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][4965] Executing command ['date', '+%z'] in directory '/root'
2019-05-18 16:36:44,660 [salt.utils.schedule:568 ][INFO    ][4965] Updating job settings for scheduled job: __mine_interval
2019-05-18 16:36:44,662 [salt.minion      :1108][INFO    ][4965] Added mine.update to scheduler
2019-05-18 16:36:44,666 [salt.minion      :1975][INFO    ][4965] Minion is starting as user 'root'
2019-05-18 16:36:44,678 [salt.minion      :2336][INFO    ][4965] Minion is ready to receive requests!
2019-05-18 16:37:18,886 [salt.minion      :1308][INFO    ][4965] User sudo_ubuntu Executing command state.sls with jid 20190518163718874370
2019-05-18 16:37:18,901 [salt.minion      :1432][INFO    ][5053] Starting a new job with PID 5053
2019-05-18 16:37:19,956 [salt.state       :915 ][INFO    ][5053] Loading fresh modules for state activity
2019-05-18 16:37:20,009 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/pool/init.sls'
2019-05-18 16:37:20,071 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:37:20,089 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:37:20,103 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:37:20,117 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:37:20,148 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/pool/calico.sls'
2019-05-18 16:37:20,209 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:37:20,221 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:37:20,231 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:37:20,241 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:37:20,311 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/pool/service.sls'
2019-05-18 16:37:20,358 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:37:20,377 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:37:20,395 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:37:20,407 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:37:20,440 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/_common.sls'
2019-05-18 16:37:20,522 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:37:20,534 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:37:20,604 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/pool/kube-proxy.sls'
2019-05-18 16:37:20,656 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:37:20,674 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:37:20,714 [salt.state       :1780][INFO    ][5053] Running state [/usr/bin/calicoctl] at time 16:37:20.714008
2019-05-18 16:37:20,714 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/usr/bin/calicoctl]
2019-05-18 16:37:29,097 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:37:29,098 [salt.state       :1951][INFO    ][5053] Completed state [/usr/bin/calicoctl] at time 16:37:29.097965 duration_in_ms=8383.957
2019-05-18 16:37:29,098 [salt.state       :1780][INFO    ][5053] Running state [/usr/bin/birdcl] at time 16:37:29.098245
2019-05-18 16:37:29,098 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/usr/bin/birdcl]
2019-05-18 16:37:29,465 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:37:29,465 [salt.state       :1951][INFO    ][5053] Completed state [/usr/bin/birdcl] at time 16:37:29.465486 duration_in_ms=367.24
2019-05-18 16:37:29,465 [salt.state       :1780][INFO    ][5053] Running state [/opt/cni/bin/calico] at time 16:37:29.465738
2019-05-18 16:37:29,466 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/opt/cni/bin/calico]
2019-05-18 16:37:33,945 [salt.minion      :1308][INFO    ][4965] User sudo_ubuntu Executing command saltutil.find_job with jid 20190518163733934997
2019-05-18 16:37:33,960 [salt.minion      :1432][INFO    ][5128] Starting a new job with PID 5128
2019-05-18 16:37:33,978 [salt.minion      :1711][INFO    ][5128] Returning information for job: 20190518163733934997
2019-05-18 16:37:36,979 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:37:36,979 [salt.state       :1951][INFO    ][5053] Completed state [/opt/cni/bin/calico] at time 16:37:36.979845 duration_in_ms=7514.106
2019-05-18 16:37:36,980 [salt.state       :1780][INFO    ][5053] Running state [/opt/cni/bin/calico-ipam] at time 16:37:36.980106
2019-05-18 16:37:36,980 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/opt/cni/bin/calico-ipam]
2019-05-18 16:37:44,278 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:37:44,278 [salt.state       :1951][INFO    ][5053] Completed state [/opt/cni/bin/calico-ipam] at time 16:37:44.278716 duration_in_ms=7298.608
2019-05-18 16:37:44,279 [salt.state       :1780][INFO    ][5053] Running state [/etc/cni/net.d/10-calico.conf] at time 16:37:44.279090
2019-05-18 16:37:44,279 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/etc/cni/net.d/10-calico.conf]
2019-05-18 16:37:44,293 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/files/calico/calico.conf'
2019-05-18 16:37:44,348 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:37:44,360 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:37:44,372 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:37:44,383 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:37:44,400 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:37:44,401 [salt.state       :1951][INFO    ][5053] Completed state [/etc/cni/net.d/10-calico.conf] at time 16:37:44.401130 duration_in_ms=122.04
2019-05-18 16:37:44,401 [salt.state       :1780][INFO    ][5053] Running state [/etc/calico/network-environment] at time 16:37:44.401535
2019-05-18 16:37:44,401 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/etc/calico/network-environment]
2019-05-18 16:37:44,418 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/files/calico/network-environment.pool'
2019-05-18 16:37:44,464 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:37:44,475 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:37:44,489 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:37:44,489 [salt.state       :1951][INFO    ][5053] Completed state [/etc/calico/network-environment] at time 16:37:44.489402 duration_in_ms=87.867
2019-05-18 16:37:44,489 [salt.state       :1780][INFO    ][5053] Running state [/etc/calico/calicoctl.cfg] at time 16:37:44.489685
2019-05-18 16:37:44,489 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/etc/calico/calicoctl.cfg]
2019-05-18 16:37:44,505 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/files/calico/calicoctl.cfg.pool'
2019-05-18 16:37:44,555 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:37:44,566 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:37:44,581 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:37:44,581 [salt.state       :1951][INFO    ][5053] Completed state [/etc/calico/calicoctl.cfg] at time 16:37:44.581665 duration_in_ms=91.979
2019-05-18 16:37:45,222 [salt.state       :1780][INFO    ][5053] Running state [containerd=1.2.5-3~u16.04+mcp] at time 16:37:45.222803
2019-05-18 16:37:45,223 [salt.state       :1813][INFO    ][5053] Executing state pkg.installed for [containerd=1.2.5-3~u16.04+mcp]
2019-05-18 16:37:45,224 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-05-18 16:37:45,617 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['apt-cache', '-q', 'policy', 'containerd=1.2.5-3~u16.04+mcp'] in directory '/root'
2019-05-18 16:37:45,722 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2019-05-18 16:37:47,902 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2019-05-18 16:37:47,924 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'containerd=1.2.5-3~u16.04+mcp'] in directory '/root'
2019-05-18 16:37:55,956 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-05-18 16:37:55,990 [salt.state       :300 ][INFO    ][5053] Made the following changes:
'containerd' changed from 'absent' to '1.2.5-3~u16.04+mcp'
'runc' changed from 'absent' to '1.0.0~rc7-2~u16.04+mcp'

2019-05-18 16:37:56,008 [salt.state       :915 ][INFO    ][5053] Loading fresh modules for state activity
2019-05-18 16:37:56,063 [salt.state       :1951][INFO    ][5053] Completed state [containerd=1.2.5-3~u16.04+mcp] at time 16:37:56.063714 duration_in_ms=10840.912
2019-05-18 16:37:56,068 [salt.state       :1780][INFO    ][5053] Running state [/etc/containerd/config.toml] at time 16:37:56.068454
2019-05-18 16:37:56,068 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/etc/containerd/config.toml]
2019-05-18 16:37:56,091 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/files/containerd/config.toml'
2019-05-18 16:37:56,149 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:37:56,161 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:37:56,182 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:37:56,182 [salt.state       :1951][INFO    ][5053] Completed state [/etc/containerd/config.toml] at time 16:37:56.182786 duration_in_ms=114.332
2019-05-18 16:37:56,644 [salt.state       :1780][INFO    ][5053] Running state [containerd] at time 16:37:56.644607
2019-05-18 16:37:56,645 [salt.state       :1813][INFO    ][5053] Executing state service.running for [containerd]
2019-05-18 16:37:56,645 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'status', 'containerd.service', '-n', '0'] in directory '/root'
2019-05-18 16:37:56,660 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-active', 'containerd.service'] in directory '/root'
2019-05-18 16:37:56,672 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-enabled', 'containerd.service'] in directory '/root'
2019-05-18 16:37:56,684 [salt.state       :300 ][INFO    ][5053] The service containerd is already running
2019-05-18 16:37:56,684 [salt.state       :1951][INFO    ][5053] Completed state [containerd] at time 16:37:56.684647 duration_in_ms=40.04
2019-05-18 16:37:56,684 [salt.state       :1780][INFO    ][5053] Running state [containerd] at time 16:37:56.684916
2019-05-18 16:37:56,685 [salt.state       :1813][INFO    ][5053] Executing state service.mod_watch for [containerd]
2019-05-18 16:37:56,686 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-active', 'containerd.service'] in directory '/root'
2019-05-18 16:37:56,697 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'containerd.service'] in directory '/root'
2019-05-18 16:37:56,720 [salt.state       :300 ][INFO    ][5053] {'containerd': True}
2019-05-18 16:37:56,720 [salt.state       :1951][INFO    ][5053] Completed state [containerd] at time 16:37:56.720776 duration_in_ms=35.86
2019-05-18 16:37:56,721 [salt.state       :1780][INFO    ][5053] Running state [/etc/systemd/system/calico-node.service] at time 16:37:56.721718
2019-05-18 16:37:56,722 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/etc/systemd/system/calico-node.service]
2019-05-18 16:37:56,739 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/files/calico/calico-node.service.ctr'
2019-05-18 16:37:56,767 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:37:56,767 [salt.state       :1951][INFO    ][5053] Completed state [/etc/systemd/system/calico-node.service] at time 16:37:56.767521 duration_in_ms=45.802
2019-05-18 16:37:56,767 [salt.state       :1780][INFO    ][5053] Running state [/var/lib/calico] at time 16:37:56.767788
2019-05-18 16:37:56,768 [salt.state       :1813][INFO    ][5053] Executing state file.directory for [/var/lib/calico]
2019-05-18 16:37:56,769 [salt.state       :300 ][INFO    ][5053] {'/var/lib/calico': 'New Dir'}
2019-05-18 16:37:56,769 [salt.state       :1951][INFO    ][5053] Completed state [/var/lib/calico] at time 16:37:56.769867 duration_in_ms=2.078
2019-05-18 16:37:56,770 [salt.state       :1780][INFO    ][5053] Running state [/var/log/calico] at time 16:37:56.770099
2019-05-18 16:37:56,770 [salt.state       :1813][INFO    ][5053] Executing state file.directory for [/var/log/calico]
2019-05-18 16:37:56,771 [salt.state       :300 ][INFO    ][5053] {'/var/log/calico': 'New Dir'}
2019-05-18 16:37:56,771 [salt.state       :1951][INFO    ][5053] Completed state [/var/log/calico] at time 16:37:56.771633 duration_in_ms=1.533
2019-05-18 16:37:56,773 [salt.state       :1780][INFO    ][5053] Running state [calico-node] at time 16:37:56.773881
2019-05-18 16:37:56,774 [salt.state       :1813][INFO    ][5053] Executing state service.running for [calico-node]
2019-05-18 16:37:56,774 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'status', 'calico-node.service', '-n', '0'] in directory '/root'
2019-05-18 16:37:56,790 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-active', 'calico-node.service'] in directory '/root'
2019-05-18 16:37:56,804 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-enabled', 'calico-node.service'] in directory '/root'
2019-05-18 16:37:56,821 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'calico-node.service'] in directory '/root'
2019-05-18 16:38:04,170 [salt.minion      :1308][INFO    ][4965] User sudo_ubuntu Executing command saltutil.find_job with jid 20190518163804157635
2019-05-18 16:38:04,193 [salt.minion      :1432][INFO    ][6245] Starting a new job with PID 6245
2019-05-18 16:38:04,217 [salt.minion      :1711][INFO    ][6245] Returning information for job: 20190518163804157635
2019-05-18 16:38:05,205 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-active', 'calico-node.service'] in directory '/root'
2019-05-18 16:38:05,217 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-enabled', 'calico-node.service'] in directory '/root'
2019-05-18 16:38:05,231 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-enabled', 'calico-node.service'] in directory '/root'
2019-05-18 16:38:05,249 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'calico-node.service'] in directory '/root'
2019-05-18 16:38:05,375 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-enabled', 'calico-node.service'] in directory '/root'
2019-05-18 16:38:05,387 [salt.state       :300 ][INFO    ][5053] {'calico-node': True}
2019-05-18 16:38:05,388 [salt.state       :1951][INFO    ][5053] Completed state [calico-node] at time 16:38:05.387960 duration_in_ms=8614.077
2019-05-18 16:38:05,391 [salt.state       :1780][INFO    ][5053] Running state [curl] at time 16:38:05.390381
2019-05-18 16:38:05,391 [salt.state       :1813][INFO    ][5053] Executing state pkg.installed for [curl]
2019-05-18 16:38:05,599 [salt.state       :300 ][INFO    ][5053] All specified packages are already installed
2019-05-18 16:38:05,600 [salt.state       :1951][INFO    ][5053] Completed state [curl] at time 16:38:05.600136 duration_in_ms=209.773
2019-05-18 16:38:05,600 [salt.state       :1780][INFO    ][5053] Running state [git] at time 16:38:05.600450
2019-05-18 16:38:05,600 [salt.state       :1813][INFO    ][5053] Executing state pkg.installed for [git]
2019-05-18 16:38:05,610 [salt.state       :300 ][INFO    ][5053] All specified packages are already installed
2019-05-18 16:38:05,610 [salt.state       :1951][INFO    ][5053] Completed state [git] at time 16:38:05.610260 duration_in_ms=9.809
2019-05-18 16:38:05,610 [salt.state       :1780][INFO    ][5053] Running state [apt-transport-https] at time 16:38:05.610618
2019-05-18 16:38:05,610 [salt.state       :1813][INFO    ][5053] Executing state pkg.installed for [apt-transport-https]
2019-05-18 16:38:05,623 [salt.state       :300 ][INFO    ][5053] All specified packages are already installed
2019-05-18 16:38:05,624 [salt.state       :1951][INFO    ][5053] Completed state [apt-transport-https] at time 16:38:05.624322 duration_in_ms=13.703
2019-05-18 16:38:05,624 [salt.state       :1780][INFO    ][5053] Running state [python-apt] at time 16:38:05.624712
2019-05-18 16:38:05,625 [salt.state       :1813][INFO    ][5053] Executing state pkg.installed for [python-apt]
2019-05-18 16:38:05,641 [salt.state       :300 ][INFO    ][5053] All specified packages are already installed
2019-05-18 16:38:05,641 [salt.state       :1951][INFO    ][5053] Completed state [python-apt] at time 16:38:05.641638 duration_in_ms=16.926
2019-05-18 16:38:05,641 [salt.state       :1780][INFO    ][5053] Running state [socat] at time 16:38:05.641880
2019-05-18 16:38:05,642 [salt.state       :1813][INFO    ][5053] Executing state pkg.installed for [socat]
2019-05-18 16:38:05,671 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2019-05-18 16:38:05,691 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'socat'] in directory '/root'
2019-05-18 16:38:07,935 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-05-18 16:38:07,973 [salt.state       :300 ][INFO    ][5053] Made the following changes:
'socat' changed from 'absent' to '1.7.3.1-1'

2019-05-18 16:38:07,987 [salt.state       :915 ][INFO    ][5053] Loading fresh modules for state activity
2019-05-18 16:38:08,029 [salt.state       :1951][INFO    ][5053] Completed state [socat] at time 16:38:08.029931 duration_in_ms=2388.05
2019-05-18 16:38:08,036 [salt.state       :1780][INFO    ][5053] Running state [openssl] at time 16:38:08.035969
2019-05-18 16:38:08,036 [salt.state       :1813][INFO    ][5053] Executing state pkg.installed for [openssl]
2019-05-18 16:38:08,689 [salt.state       :300 ][INFO    ][5053] All specified packages are already installed
2019-05-18 16:38:08,690 [salt.state       :1951][INFO    ][5053] Completed state [openssl] at time 16:38:08.689972 duration_in_ms=654.002
2019-05-18 16:38:08,690 [salt.state       :1780][INFO    ][5053] Running state [conntrack] at time 16:38:08.690290
2019-05-18 16:38:08,690 [salt.state       :1813][INFO    ][5053] Executing state pkg.installed for [conntrack]
2019-05-18 16:38:08,717 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2019-05-18 16:38:08,740 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'conntrack'] in directory '/root'
2019-05-18 16:38:10,724 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-05-18 16:38:10,769 [salt.state       :300 ][INFO    ][5053] Made the following changes:
'conntrack' changed from 'absent' to '1:1.4.3-3'

2019-05-18 16:38:10,796 [salt.state       :915 ][INFO    ][5053] Loading fresh modules for state activity
2019-05-18 16:38:10,838 [salt.state       :1951][INFO    ][5053] Completed state [conntrack] at time 16:38:10.838357 duration_in_ms=2148.066
2019-05-18 16:38:10,841 [salt.state       :1780][INFO    ][5053] Running state [/usr/bin/hyperkube] at time 16:38:10.841921
2019-05-18 16:38:10,842 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/usr/bin/hyperkube]
2019-05-18 16:38:34,250 [salt.minion      :1308][INFO    ][4965] User sudo_ubuntu Executing command saltutil.find_job with jid 20190518163834237263
2019-05-18 16:38:34,266 [salt.minion      :1432][INFO    ][7344] Starting a new job with PID 7344
2019-05-18 16:38:34,283 [salt.minion      :1711][INFO    ][7344] Returning information for job: 20190518163834237263
2019-05-18 16:38:54,537 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:38:54,538 [salt.state       :1951][INFO    ][5053] Completed state [/usr/bin/hyperkube] at time 16:38:54.538365 duration_in_ms=43696.442
2019-05-18 16:38:54,540 [salt.state       :1780][INFO    ][5053] Running state [/usr/bin/kubectl] at time 16:38:54.539942
2019-05-18 16:38:54,540 [salt.state       :1813][INFO    ][5053] Executing state file.symlink for [/usr/bin/kubectl]
2019-05-18 16:38:54,551 [salt.state       :300 ][INFO    ][5053] {'new': '/usr/bin/kubectl'}
2019-05-18 16:38:54,563 [salt.state       :915 ][INFO    ][5053] Loading fresh modules for state activity
2019-05-18 16:38:54,604 [salt.state       :1951][INFO    ][5053] Completed state [/usr/bin/kubectl] at time 16:38:54.604528 duration_in_ms=64.586
2019-05-18 16:38:54,607 [salt.state       :1780][INFO    ][5053] Running state [/tmp/crictl] at time 16:38:54.607599
2019-05-18 16:38:54,607 [salt.state       :1813][INFO    ][5053] Executing state archive.extracted for [/tmp/crictl]
2019-05-18 16:38:56,733 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['tar', 'xz', '-f', '/var/cache/salt/minion/extrn_files/base/github.com/kubernetes-sigs/cri-tools/releases/download/v1.12.0/crictl-v1.12.0-linux-amd64.tar.gz'] in directory '/tmp/crictl/'
2019-05-18 16:38:56,961 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['tar', '--version'] in directory '/root'
2019-05-18 16:38:56,972 [salt.state       :300 ][INFO    ][5053] {'extracted_files': 'no tar output so far', 'directories_created': ['/tmp/crictl/']}
2019-05-18 16:38:56,973 [salt.state       :1951][INFO    ][5053] Completed state [/tmp/crictl] at time 16:38:56.973317 duration_in_ms=2365.713
2019-05-18 16:38:56,974 [salt.state       :1780][INFO    ][5053] Running state [/usr/local/bin/crictl] at time 16:38:56.974470
2019-05-18 16:38:56,974 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/usr/local/bin/crictl]
2019-05-18 16:38:56,975 [salt.loaded.int.states.file:1019][WARNING ][5053] Use of argument owner found, "owner" is invalid, please use "user"
2019-05-18 16:38:57,288 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:38:57,288 [salt.state       :1951][INFO    ][5053] Completed state [/usr/local/bin/crictl] at time 16:38:57.288887 duration_in_ms=314.419
2019-05-18 16:38:57,289 [salt.state       :1780][INFO    ][5053] Running state [/etc/crictl.yaml] at time 16:38:57.289163
2019-05-18 16:38:57,289 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/etc/crictl.yaml]
2019-05-18 16:38:57,292 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:38:57,292 [salt.state       :1951][INFO    ][5053] Completed state [/etc/crictl.yaml] at time 16:38:57.292705 duration_in_ms=3.542
2019-05-18 16:38:57,292 [salt.state       :1780][INFO    ][5053] Running state [/etc/criproxy] at time 16:38:57.292950
2019-05-18 16:38:57,293 [salt.state       :1813][INFO    ][5053] Executing state file.absent for [/etc/criproxy]
2019-05-18 16:38:57,293 [salt.state       :300 ][INFO    ][5053] File /etc/criproxy is not present
2019-05-18 16:38:57,293 [salt.state       :1951][INFO    ][5053] Completed state [/etc/criproxy] at time 16:38:57.293758 duration_in_ms=0.808
2019-05-18 16:38:57,815 [salt.state       :1780][INFO    ][5053] Running state [criproxy] at time 16:38:57.815100
2019-05-18 16:38:57,815 [salt.state       :1813][INFO    ][5053] Executing state service.dead for [criproxy]
2019-05-18 16:38:57,816 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'status', 'criproxy.service', '-n', '0'] in directory '/root'
2019-05-18 16:38:57,831 [salt.state       :300 ][INFO    ][5053] The named service criproxy is not available
2019-05-18 16:38:57,831 [salt.state       :1951][INFO    ][5053] Completed state [criproxy] at time 16:38:57.831778 duration_in_ms=16.679
2019-05-18 16:38:57,832 [salt.state       :1780][INFO    ][5053] Running state [/etc/systemd/system/kubelet.service] at time 16:38:57.832134
2019-05-18 16:38:57,832 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/etc/systemd/system/kubelet.service]
2019-05-18 16:38:57,849 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/files/systemd/kubelet.service'
2019-05-18 16:38:57,896 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:38:58,025 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:38:58,142 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:38:58,142 [salt.state       :1951][INFO    ][5053] Completed state [/etc/systemd/system/kubelet.service] at time 16:38:58.142774 duration_in_ms=310.639
2019-05-18 16:38:58,143 [salt.state       :1780][INFO    ][5053] Running state [/etc/kubernetes/config] at time 16:38:58.143103
2019-05-18 16:38:58,143 [salt.state       :1813][INFO    ][5053] Executing state file.absent for [/etc/kubernetes/config]
2019-05-18 16:38:58,143 [salt.state       :300 ][INFO    ][5053] File /etc/kubernetes/config is not present
2019-05-18 16:38:58,144 [salt.state       :1951][INFO    ][5053] Completed state [/etc/kubernetes/config] at time 16:38:58.144063 duration_in_ms=0.96
2019-05-18 16:38:58,144 [salt.state       :1780][INFO    ][5053] Running state [/etc/default/kubelet] at time 16:38:58.144326
2019-05-18 16:38:58,144 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/etc/default/kubelet]
2019-05-18 16:38:58,159 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/files/kubelet/default.pool'
2019-05-18 16:38:58,238 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:38:58,355 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:38:58,480 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:38:58,608 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:38:58,762 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:38:58,879 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:38:59,005 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:38:59,006 [salt.state       :1951][INFO    ][5053] Completed state [/etc/default/kubelet] at time 16:38:59.005957 duration_in_ms=861.631
2019-05-18 16:38:59,006 [salt.state       :1780][INFO    ][5053] Running state [/etc/kubernetes/kubelet.kubeconfig] at time 16:38:59.006386
2019-05-18 16:38:59,006 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/etc/kubernetes/kubelet.kubeconfig]
2019-05-18 16:38:59,025 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/files/kubelet/kubelet.kubeconfig.pool'
2019-05-18 16:38:59,075 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:38:59,194 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:38:59,325 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:38:59,464 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:38:59,602 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:38:59,603 [salt.state       :1951][INFO    ][5053] Completed state [/etc/kubernetes/kubelet.kubeconfig] at time 16:38:59.602945 duration_in_ms=596.559
2019-05-18 16:38:59,603 [salt.state       :1780][INFO    ][5053] Running state [/etc/kubernetes/manifests] at time 16:38:59.603283
2019-05-18 16:38:59,603 [salt.state       :1813][INFO    ][5053] Executing state file.directory for [/etc/kubernetes/manifests]
2019-05-18 16:38:59,605 [salt.state       :300 ][INFO    ][5053] {'/etc/kubernetes/manifests': 'New Dir'}
2019-05-18 16:38:59,605 [salt.state       :1951][INFO    ][5053] Completed state [/etc/kubernetes/manifests] at time 16:38:59.605614 duration_in_ms=2.33
2019-05-18 16:38:59,608 [salt.state       :1780][INFO    ][5053] Running state [kubelet] at time 16:38:59.608127
2019-05-18 16:38:59,608 [salt.state       :1813][INFO    ][5053] Executing state service.running for [kubelet]
2019-05-18 16:38:59,609 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'status', 'kubelet.service', '-n', '0'] in directory '/root'
2019-05-18 16:38:59,624 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-active', 'kubelet.service'] in directory '/root'
2019-05-18 16:38:59,635 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-enabled', 'kubelet.service'] in directory '/root'
2019-05-18 16:38:59,658 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'kubelet.service'] in directory '/root'
2019-05-18 16:38:59,679 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-active', 'kubelet.service'] in directory '/root'
2019-05-18 16:38:59,691 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-enabled', 'kubelet.service'] in directory '/root'
2019-05-18 16:38:59,707 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-enabled', 'kubelet.service'] in directory '/root'
2019-05-18 16:38:59,727 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'kubelet.service'] in directory '/root'
2019-05-18 16:38:59,821 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-enabled', 'kubelet.service'] in directory '/root'
2019-05-18 16:38:59,833 [salt.state       :300 ][INFO    ][5053] {'kubelet': True}
2019-05-18 16:38:59,833 [salt.state       :1951][INFO    ][5053] Completed state [kubelet] at time 16:38:59.833431 duration_in_ms=225.304
2019-05-18 16:38:59,833 [salt.state       :1780][INFO    ][5053] Running state [/etc/logrotate.d/kubernetes] at time 16:38:59.833768
2019-05-18 16:38:59,834 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/etc/logrotate.d/kubernetes]
2019-05-18 16:38:59,849 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/files/logrotate'
2019-05-18 16:38:59,858 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:38:59,859 [salt.state       :1951][INFO    ][5053] Completed state [/etc/logrotate.d/kubernetes] at time 16:38:59.859095 duration_in_ms=25.327
2019-05-18 16:38:59,859 [salt.state       :1780][INFO    ][5053] Running state [/opt/cni/bin] at time 16:38:59.859334
2019-05-18 16:38:59,859 [salt.state       :1813][INFO    ][5053] Executing state archive.extracted for [/opt/cni/bin]
2019-05-18 16:39:04,310 [salt.minion      :1308][INFO    ][4965] User sudo_ubuntu Executing command saltutil.find_job with jid 20190518163904299050
2019-05-18 16:39:04,322 [salt.minion      :1432][INFO    ][7733] Starting a new job with PID 7733
2019-05-18 16:39:04,338 [salt.minion      :1711][INFO    ][7733] Returning information for job: 20190518163904299050
2019-05-18 16:39:05,261 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['tar', 'xz', '-f', '/var/cache/salt/minion/extrn_files/base/docker-prod-local.artifactory.mirantis.com/artifactory/binary-prod-local/mirantis/kubernetes/containernetworking-plugins/containernetworking-plugins_v0.7.2-173-g8db2808.tar.gz'] in directory '/opt/cni/bin/'
2019-05-18 16:39:05,873 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['tar', '--version'] in directory '/root'
2019-05-18 16:39:05,892 [salt.state       :300 ][INFO    ][5053] {'extracted_files': 'no tar output so far'}
2019-05-18 16:39:05,892 [salt.state       :1951][INFO    ][5053] Completed state [/opt/cni/bin] at time 16:39:05.892536 duration_in_ms=6033.194
2019-05-18 16:39:05,893 [salt.state       :1780][INFO    ][5053] Running state [/etc/kubernetes/proxy.kubeconfig] at time 16:39:05.893208
2019-05-18 16:39:05,893 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/etc/kubernetes/proxy.kubeconfig]
2019-05-18 16:39:05,916 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/files/kube-proxy/proxy.kubeconfig'
2019-05-18 16:39:05,967 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:39:06,131 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:39:06,272 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/-.*//g' -e 's/v//g' -e 's/Kubernetes //g' | awk -F'.' '{print $1 "." $2}'' in directory '/root'
2019-05-18 16:39:06,400 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command '(hyperkube --version kubelet 2> /dev/null || echo '0.0') | sed -e 's/+.*//g' -e 's/v//g' -e 's/Kubernetes //g'' in directory '/root'
2019-05-18 16:39:06,532 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:39:06,533 [salt.state       :1951][INFO    ][5053] Completed state [/etc/kubernetes/proxy.kubeconfig] at time 16:39:06.532928 duration_in_ms=639.719
2019-05-18 16:39:06,533 [salt.state       :1780][INFO    ][5053] Running state [/etc/systemd/system/kube-proxy.service] at time 16:39:06.533303
2019-05-18 16:39:06,533 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/etc/systemd/system/kube-proxy.service]
2019-05-18 16:39:06,552 [salt.fileclient  :1219][INFO    ][5053] Fetching file from saltenv 'base', ** done ** 'kubernetes/files/systemd/kube-proxy.service'
2019-05-18 16:39:06,562 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:39:06,562 [salt.state       :1951][INFO    ][5053] Completed state [/etc/systemd/system/kube-proxy.service] at time 16:39:06.562703 duration_in_ms=29.4
2019-05-18 16:39:06,562 [salt.state       :1780][INFO    ][5053] Running state [/etc/default/kube-proxy] at time 16:39:06.562937
2019-05-18 16:39:06,563 [salt.state       :1813][INFO    ][5053] Executing state file.managed for [/etc/default/kube-proxy]
2019-05-18 16:39:06,564 [salt.state       :300 ][INFO    ][5053] File changed:
New file
2019-05-18 16:39:06,565 [salt.state       :1951][INFO    ][5053] Completed state [/etc/default/kube-proxy] at time 16:39:06.565166 duration_in_ms=2.228
2019-05-18 16:39:06,566 [salt.state       :1780][INFO    ][5053] Running state [kube-proxy] at time 16:39:06.566861
2019-05-18 16:39:06,567 [salt.state       :1813][INFO    ][5053] Executing state service.running for [kube-proxy]
2019-05-18 16:39:06,567 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'status', 'kube-proxy.service', '-n', '0'] in directory '/root'
2019-05-18 16:39:06,589 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-active', 'kube-proxy.service'] in directory '/root'
2019-05-18 16:39:06,606 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-enabled', 'kube-proxy.service'] in directory '/root'
2019-05-18 16:39:06,628 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'kube-proxy.service'] in directory '/root'
2019-05-18 16:39:06,657 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-active', 'kube-proxy.service'] in directory '/root'
2019-05-18 16:39:06,670 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-enabled', 'kube-proxy.service'] in directory '/root'
2019-05-18 16:39:06,685 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-enabled', 'kube-proxy.service'] in directory '/root'
2019-05-18 16:39:06,704 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'kube-proxy.service'] in directory '/root'
2019-05-18 16:39:06,810 [salt.loaded.int.module.cmdmod:395 ][INFO    ][5053] Executing command ['systemctl', 'is-enabled', 'kube-proxy.service'] in directory '/root'
2019-05-18 16:39:06,823 [salt.state       :300 ][INFO    ][5053] {'kube-proxy': True}
2019-05-18 16:39:06,823 [salt.state       :1951][INFO    ][5053] Completed state [kube-proxy] at time 16:39:06.823436 duration_in_ms=256.574
2019-05-18 16:39:06,827 [salt.minion      :1711][INFO    ][5053] Returning information for job: 20190518163718874370
2019-05-18 16:39:14,669 [salt.minion      :1308][INFO    ][4965] User sudo_ubuntu Executing command cmd.run with jid 20190518163914657623
2019-05-18 16:39:14,686 [salt.minion      :1432][INFO    ][7957] Starting a new job with PID 7957
2019-05-18 16:39:14,695 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7957] Executing command 'calicoctl node status' in directory '/root'
2019-05-18 16:39:14,744 [salt.minion      :1711][INFO    ][7957] Returning information for job: 20190518163914657623
2019-05-18 16:39:15,390 [salt.minion      :1308][INFO    ][4965] User sudo_ubuntu Executing command cmd.run with jid 20190518163915381705
2019-05-18 16:39:15,407 [salt.minion      :1432][INFO    ][7976] Starting a new job with PID 7976
2019-05-18 16:39:15,418 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7976] Executing command 'calicoctl get ippool' in directory '/root'
2019-05-18 16:39:15,547 [salt.minion      :1711][INFO    ][7976] Returning information for job: 20190518163915381705
2019-05-18 16:40:15,255 [salt.minion      :1308][INFO    ][4965] User sudo_ubuntu Executing command cp.push_dir with jid 20190518164015245335
2019-05-18 16:40:15,274 [salt.minion      :1432][INFO    ][8093] Starting a new job with PID 8093
2019-05-18 16:40:15,680 [salt.minion      :1711][INFO    ][8093] Returning information for job: 20190518164015245335
2019-05-18 16:42:57,823 [salt.minion      :1308][INFO    ][4965] User sudo_ubuntu Executing command cp.push_dir with jid 20190518164257807017
2019-05-18 16:42:57,839 [salt.minion      :1432][INFO    ][9051] Starting a new job with PID 9051
