Jan 03 17:40:56 clr-01 crio[22892]: 2019-01-03 17:40:56.158 [INFO][5294] calico.go 75: Extracted identifiers EndpointIDs=&utils.WEPIdentifiers{Namespace:"default", WEPName:"", WorkloadEndpointIdentifiers:names.WorkloadEndpointIdentifiers{Node:"clr-01", Orchestrator:"k8s", Endpoint:"eth0", Workload:"", Pod:"test-cpumanager-kata", ContainerID:"e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b"}}

Jan 03 17:40:56 clr-01 crio[22892]: 2019-01-03 17:40:56.187 [INFO][5294] calico.go 166: Calico CNI found existing endpoint: &{{WorkloadEndpoint projectcalico.org/v3} {clr--01-k8s-test--cpumanager--kata-eth0  default  b91bd72c-0f7e-11e9-a5de-5254003ca334 1636 0 2019-01-03 17:40:55 +0000 UTC <nil> <nil> map[projectcalico.org/namespace:default projectcalico.org/orchestrator:k8s projectcalico.org/serviceaccount:default] map[] [] nil [] } {k8s  clr-01  test-cpumanager-kata eth0 [] []   [kns.default ksa.default.default] calid51be51c92d  []}} ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b" Namespace="default" Pod="test-cpumanager-kata" WorkloadEndpoint="clr--01-k8s-test--cpumanager--kata-"

Jan 03 17:40:56 clr-01 crio[22892]: 2019-01-03 17:40:56.187 [INFO][5294] k8s.go 60: Extracted identifiers for CmdAddK8s ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b" Namespace="default" Pod="test-cpumanager-kata" WorkloadEndpoint="clr--01-k8s-test--cpumanager--kata-eth0"

Jan 03 17:40:56 clr-01 crio[22892]: Calico CNI fetching podCidr from Kubernetes

Jan 03 17:40:56 clr-01 crio[22892]: 2019-01-03 17:40:56.192 [INFO][5294] utils.go 261: Fetched podCidr ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b" Namespace="default" Pod="test-cpumanager-kata" WorkloadEndpoint="clr--01-k8s-test--cpumanager--kata-eth0" podCidr="10.244.0.0/24"

Jan 03 17:40:56 clr-01 crio[22892]: Calico CNI passing podCidr to host-local IPAM: 10.244.0.0/24

Jan 03 17:40:56 clr-01 crio[22892]: 2019-01-03 17:40:56.194 [INFO][5294] k8s.go 785: namespace info &Namespace{ObjectMeta:k8s_io_apimachinery_pkg_apis_meta_v1.ObjectMeta{Name:default,GenerateName:,Namespace:,SelfLink:/api/v1/namespaces/default,UID:85187855-0f7c-11e9-a5de-5254003ca334,ResourceVersion:5,Generation:0,CreationTimestamp:2019-01-03 17:25:09 +0000 UTC,DeletionTimestamp:<nil>,DeletionGracePeriodSeconds:nil,Labels:map[string]string{},Annotations:map[string]string{},OwnerReferences:[],Finalizers:[],ClusterName:,Initializers:nil,},Spec:NamespaceSpec{Finalizers:[kubernetes],},Status:NamespaceStatus{Phase:Active,},}

Jan 03 17:40:56 clr-01 crio[22892]: 2019-01-03 17:40:56.197 [INFO][5294] k8s.go 794: pod info &Pod{ObjectMeta:k8s_io_apimachinery_pkg_apis_meta_v1.ObjectMeta{Name:test-cpumanager-kata,GenerateName:,Namespace:default,SelfLink:/api/v1/namespaces/default/pods/test-cpumanager-kata,UID:b91bd72c-0f7e-11e9-a5de-5254003ca334,ResourceVersion:1636,Generation:0,CreationTimestamp:2019-01-03 17:40:55 +0000 UTC,DeletionTimestamp:<nil>,DeletionGracePeriodSeconds:nil,Labels:map[string]string{},Annotations:map[string]string{kubectl.kubernetes.io/last-applied-configuration: {"apiVersion":"v1","kind":"Pod","metadata":{"annotations":{},"name":"test-cpumanager-kata","namespace":"default"},"spec":{"containers":[{"command":["top"],"image":"busybox","name":"taskset","resources":{"limits":{"cpu":1,"memory":"500Mi"}}}],"restartPolicy":"Never","runtimeClassName":"kata"}}

Jan 03 17:40:56 clr-01 crio[22892]: ,},OwnerReferences:[],Finalizers:[],ClusterName:,Initializers:nil,},Spec:PodSpec{Volumes:[{default-token-8w8x5 {nil nil nil nil nil SecretVolumeSource{SecretName:default-token-8w8x5,Items:[],DefaultMode:*420,Optional:nil,} nil nil nil nil nil nil nil nil nil nil nil nil nil nil nil nil nil nil nil nil nil}}],Containers:[{taskset busybox [top] []  [] [] [] {map[memory:{{524288000 0} {<nil>} 500Mi BinarySI} cpu:{{1 0} {<nil>} 1 DecimalSI}] map[cpu:{{1 0} {<nil>} 1 DecimalSI} memory:{{524288000 0} {<nil>} 500Mi BinarySI}]} [{default-token-8w8x5 true /var/run/secrets/kubernetes.io/serviceaccount  <nil>}] [] nil nil nil /dev/termination-log File Always nil false false false}],RestartPolicy:Never,TerminationGracePeriodSeconds:*30,ActiveDeadlineSeconds:nil,DNSPolicy:ClusterFirst,NodeSelector:map[string]string{},ServiceAccountName:default,DeprecatedServiceAccount:default,NodeName:clr-01,HostNetwork:false,HostPID:false,HostIPC:false,SecurityContext:&PodSecurityContext{SELinuxOptions:nil,RunAsUser:nil,RunAsNonRoot:nil,SupplementalGroups:[],FSGroup:nil,RunAsGroup:nil,Sysctls:[],},ImagePullSecrets:[],Hostname:,Subdomain:,Affinity:nil,SchedulerName:default-scheduler,InitContainers:[],AutomountServiceAccountToken:nil,Tolerations:[{node.kubernetes.io/not-ready Exists  NoExecute 0xc420357ee0} {node.kubernetes.io/unreachable Exists  NoExecute 0xc420357f00}],HostAliases:[],PriorityClassName:,Priority:*0,DNSConfig:nil,ShareProcessNamespace:nil,ReadinessGates:[],},Status:PodStatus{Phase:Pending,Conditions:[{Initialized True 0001-01-01 00:00:00 +0000 UTC 2019-01-03 17:40:55 +0000 UTC  } {Ready False 0001-01-01 00:00:00 +0000 UTC 2019-01-03 17:40:55 +0000 UTC ContainersNotReady containers with unready status: [taskset]} {ContainersReady False 0001-01-01 00:00:00 +0000 UTC 2019-01-03 17:40:55 +0000 UTC ContainersNotReady containers with unready status: [taskset]} {PodScheduled True 0001-01-01 00:00:00 +0000 UTC 2019-01-03 17:40:55 +0000 UTC  }],Message:,Reason:,HostIP:192.168.121.54,PodIP:,StartTime:2019-01-03 17:40:55 +0000 UTC,ContainerStatuses:[{taskset {ContainerStateWaiting{Reason:ContainerCreating,Message:,} nil nil} {nil nil nil} false 0 busybox  }],QOSClass:Guaranteed,InitContainerStatuses:[],NominatedNodeName:,},}

Jan 03 17:40:56 clr-01 crio[22892]: 2019-01-03 17:40:56.201 [INFO][5294] k8s.go 365: Populated endpoint ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b" Namespace="default" Pod="test-cpumanager-kata" WorkloadEndpoint="clr--01-k8s-test--cpumanager--kata-eth0" endpoint=&v3.WorkloadEndpoint{TypeMeta:v1.TypeMeta{Kind:"WorkloadEndpoint", APIVersion:"projectcalico.org/v3"}, ObjectMeta:v1.ObjectMeta{Name:"clr--01-k8s-test--cpumanager--kata-eth0", GenerateName:"", Namespace:"default", SelfLink:"", UID:"b91bd72c-0f7e-11e9-a5de-5254003ca334", ResourceVersion:"1636", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63682134055, loc:(*time.Location)(0x1edd720)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"projectcalico.org/orchestrator":"k8s", "projectcalico.org/serviceaccount":"default", "projectcalico.org/namespace":"default"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string(nil), ClusterName:""}, Spec:v3.WorkloadEndpointSpec{Orchestrator:"k8s", Workload:"", Node:"clr-01", ContainerID:"", Pod:"test-cpumanager-kata", Endpoint:"eth0", IPNetworks:[]string{"10.244.0.5/32"}, IPNATs:[]v3.IPNAT(nil), IPv4Gateway:"", IPv6Gateway:"", Profiles:[]string{"kns.default", "ksa.default.default"}, InterfaceName:"calid51be51c92d", MAC:"", Ports:[]v3.EndpointPort(nil)}}

Jan 03 17:40:56 clr-01 crio[22892]: Calico CNI using IPs: [10.244.0.5/32]

Jan 03 17:40:56 clr-01 crio[22892]: 2019-01-03 17:40:56.201 [INFO][5294] network.go 75: Setting the host side veth name to calid51be51c92d ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b" Namespace="default" Pod="test-cpumanager-kata" WorkloadEndpoint="clr--01-k8s-test--cpumanager--kata-eth0"

Jan 03 17:40:56 clr-01 crio[22892]: 2019-01-03 17:40:56.202 [INFO][5294] network.go 380: Disabling IPv4 forwarding ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b" Namespace="default" Pod="test-cpumanager-kata" WorkloadEndpoint="clr--01-k8s-test--cpumanager--kata-eth0"

Jan 03 17:40:56 clr-01 kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready

Jan 03 17:40:56 clr-01 kernel: IPv6: ADDRCONF(NETDEV_UP): calid51be51c92d: link is not ready

Jan 03 17:40:56 clr-01 crio[22892]: 2019-01-03 17:40:56.216 [INFO][5294] k8s.go 392: Added Mac, interface name, and active container ID to endpoint ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b" Namespace="default" Pod="test-cpumanager-kata" WorkloadEndpoint="clr--01-k8s-test--cpumanager--kata-eth0" endpoint=&v3.WorkloadEndpoint{TypeMeta:v1.TypeMeta{Kind:"WorkloadEndpoint", APIVersion:"projectcalico.org/v3"}, ObjectMeta:v1.ObjectMeta{Name:"clr--01-k8s-test--cpumanager--kata-eth0", GenerateName:"", Namespace:"default", SelfLink:"", UID:"b91bd72c-0f7e-11e9-a5de-5254003ca334", ResourceVersion:"1636", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63682134055, loc:(*time.Location)(0x1edd720)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"projectcalico.org/namespace":"default", "projectcalico.org/orchestrator":"k8s", "projectcalico.org/serviceaccount":"default"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string(nil), ClusterName:""}, Spec:v3.WorkloadEndpointSpec{Orchestrator:"k8s", Workload:"", Node:"clr-01", ContainerID:"e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b", Pod:"test-cpumanager-kata", Endpoint:"eth0", IPNetworks:[]string{"10.244.0.5/32"}, IPNATs:[]v3.IPNAT(nil), IPv4Gateway:"", IPv6Gateway:"", Profiles:[]string{"kns.default", "ksa.default.default"}, InterfaceName:"calid51be51c92d", MAC:"46:40:30:22:10:8d", Ports:[]v3.EndpointPort(nil)}}

Jan 03 17:40:56 clr-01 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): calid51be51c92d: link becomes ready

Jan 03 17:40:56 clr-01 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready

Jan 03 17:40:56 clr-01 systemd-networkd[10388]: calid51be51c92d: Gained carrier

Jan 03 17:40:56 clr-01 systemd-udevd[5320]: link_config: autonegotiation is unset or enabled, the speed and duplex are not writable.

Jan 03 17:40:56 clr-01 crio[22892]: 2019-01-03 17:40:56.223 [INFO][5294] k8s.go 424: Wrote updated endpoint to datastore ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b" Namespace="default" Pod="test-cpumanager-kata" WorkloadEndpoint="clr--01-k8s-test--cpumanager--kata-eth0"

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.287350313Z" level=info msg="loaded configuration" arch=amd64 command=create file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5333 source=katautils

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.287797462Z" level=info arch=amd64 arguments="\"create --bundle /var/run/containers/storage/overlay-containers/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/userdata --pid-file /var/run/containers/storage/overlay-containers/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/userdata/pidfile e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b\"" command=create commit= name=kata-runtime pid=5333 source=runtime version=1.5.0-rc2

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.290387414Z" level=info msg="shm-size detected: 67108864" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=oci

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.29937925Z" level=warning msg="fetch sandbox device failed" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b error="open /run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/devices.json: no such file or directory" name=kata-runtime pid=5333 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b sandboxid=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.300129048Z" level=info msg="Endpoints found after scan" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b endpoints="[0xc000436a00]" name=kata-runtime pid=5333 source=virtcontainers subsystem=network

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.300261092Z" level=info msg="Attaching endpoint" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b endpoint-type=virtual hotplug=false name=kata-runtime pid=5333 source=virtcontainers subsystem=default-network

Jan 03 17:40:56 clr-01 kernel: device eth0 entered promiscuous mode

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.302274684Z" level=info msg="Starting VM" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.302636252Z" level=info msg="Adding extra file [0xc0000c7110 0xc0000c7100]" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=qmp

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.302713139Z" level=info msg="launching /usr/bin/kata-qemu-lite-system-x86_64 with: [-name sandbox-e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b -uuid 86bfb9f1-0cd9-48b8-a658-b1a154078f9f -machine pc,accel=kvm,kernel_irqchip,nvdimm -cpu host,pmu=off -qmp unix:/run/vc/vm/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/qmp.sock,server,nowait -m 2048M,slots=10,maxmem=17037M -device pci-bridge,bus=pci.0,id=pci-bridge-0,chassis_nr=1,shpc=on,addr=2,romfile= -device virtio-serial-pci,disable-modern=true,id=serial0,romfile= -device virtconsole,chardev=charconsole0,id=console0 -chardev socket,id=charconsole0,path=/run/vc/vm/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/console.sock,server,nowait -device nvdimm,id=nv0,memdev=mem0 -object memory-backend-file,id=mem0,mem-path=/usr/share/kata-containers/kata-containers-image_clearlinux_1.5.0-rc2_agent_91a87bc7176.img,size=536870912 -device virtio-scsi-pci,id=scsi0,disable-modern=true,romfile= -object rng-random,id=rng0,filename=/dev/urandom -device virtio-rng,rng=rng0,romfile= -device virtserialport,chardev=charch0,id=channel0,name=agent.channel.0 -chardev socket,id=charch0,path=/run/vc/vm/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/kata.sock,server,nowait -device virtio-9p-pci,disable-modern=true,fsdev=extra-9p-kataShared,mount_tag=kataShared,romfile= -fsdev local,id=extra-9p-kataShared,path=/run/kata-containers/shared/sandboxes/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b,security_model=none -netdev tap,id=network-0,vhost=on,vhostfds=3,fds=4 -device driver=virtio-net-pci,netdev=network-0,mac=46:40:30:22:10:8d,disable-modern=true,mq=on,vectors=4,romfile= -global kvm-pit.lost_tick_policy=discard -vga none -no-user-config -nodefaults -nographic -daemonize -kernel /usr/share/kata-containers/vmlinuz-4.14.90-8.container -append tsc=reliable no_timer_check rcupdate.rcu_expedited=1 i8042.direct=1 i8042.dumbkbd=1 i8042.nopnp=1 i8042.noaux=1 noreplace-smp reboot=kconsole=hvc0 console=hvc1 iommu=off cryptomgr.notests net.ifnames=0 pci=lastbus=0 root=/dev/pmem0p1 rootflags=dax,data=ordered,errors=remount-ro rw rootfstype=ext4 quiet systemd.show_status=false panic=1 nr_cpus=16 init=/usr/lib/systemd/systemd systemd.unit=kata-containers.target systemd.mask=systemd-networkd.service systemd.mask=systemd-networkd.socket -smp 1,cores=1,threads=1,sockets=1,maxcpus=16]" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=qmp

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.401208156Z" level=info msg="{\"QMP\": {\"version\": {\"qemu\": {\"micro\": 0, \"minor\": 11, \"major\": 2}, \"package\":\"\"}, \"capabilities\": []}}" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=qmp

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.40155229Z" level=info msg="QMP details" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 qmp-capabilities= qmp-major-version=2 qmp-micro-version=0 qmp-minor-version=11 source=virtcontainers subsystem=qemu

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.401781772Z" level=info msg="{\"execute\":\"qmp_capabilities\"}" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=qmp

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.402130395Z" level=info msg="{\"return\": {}}" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=qmp

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.402455719Z" level=info msg="VM started" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.403348034Z" level=info msg="Starting regular Kata proxy rather than built-in" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=kata_agent

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.405053842Z" level=info msg="proxy started" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 proxy-pid=5362 proxy-url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock" sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=kata_agent

Jan 03 17:40:56 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:56.405174073Z" level=info msg="New client" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:40:57 clr-01 systemd-networkd[10388]: calid51be51c92d: Gained IPv6LL

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.583530269Z" level=warning msg="unsupported address" address="fe80::4440:30ff:fe22:108d/64" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=network unsupported-address-type=ipv6

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.583717869Z" level=warning msg="unsupported route" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b destination="fe80::/64" name=kata-runtime pid=5333 source=virtcontainers subsystem=network unsupported-route-type=ipv6

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.583816567Z" level=warning msg="unsupported route" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b destination="ff00::/8" name=kata-runtime pid=5333 source=virtcontainers subsystem=network unsupported-route-type=ipv6

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.583869606Z" level=info msg="New client" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.605021505Z" level=info msg="New client" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.617673106Z" level=info msg="New client" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.637636736Z" level=info msg="New client" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.641703984Z" level=info msg="{\"QMP\": {\"version\": {\"qemu\": {\"micro\": 0, \"minor\": 11, \"major\": 2}, \"package\":\"\"}, \"capabilities\": []}}" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=qmp

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.642050056Z" level=info msg="{\"execute\":\"qmp_capabilities\"}" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=qmp

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.675660335Z" level=info msg="{\"return\": {}}" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=qmp

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.675892691Z" level=info msg="New client" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.690284082Z" level=info msg="device details" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b device-major=0 device-minor=178 mount-point=/var/lib/containers/storage/overlay/fa1c3a01c9c32ece73eec5dd11f1d45fe9059d338c9c8e434e32d444a4d975f3/merged name=kata-runtime pid=5333 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=container

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.692947131Z" level=info msg="Using sandbox shm" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 shm-size=67108864 source=virtcontainers subsystem=kata_agent

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.693063247Z" level=info msg="New client" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.930389084Z" level=info msg="{\"execute\":\"query-cpus\"}" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=qmp

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.931605424Z" level=info msg="{\"return\": [{\"arch\": \"x86\", \"current\": true, \"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 0}, \"CPU\": 0, \"qom_path\": \"/machine/unattached/device[0]\", \"pc\": -2130509130, \"halted\": false, \"thread_id\": 5356}]}" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 source=virtcontainers subsystem=qmp

Jan 03 17:40:58 clr-01 kata-runtime[5333]: time="2019-01-03T17:40:58.933765268Z" level=info msg="release sandbox" arch=amd64 command=create container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5333 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:40:58 clr-01 kata-runtime[5392]: time="2019-01-03T17:40:58.989950659Z" level=info msg="loaded configuration" arch=amd64 command=start file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5392 source=katautils

Jan 03 17:40:58 clr-01 kata-runtime[5392]: time="2019-01-03T17:40:58.990199683Z" level=info arch=amd64 arguments="\"start e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b\""command=start commit= name=kata-runtime pid=5392 source=runtime version=1.5.0-rc2

Jan 03 17:40:58 clr-01 kata-runtime[5392]: time="2019-01-03T17:40:58.990407649Z" level=info msg="fetch sandbox" arch=amd64 command=start container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5392 source=virtcontainers

Jan 03 17:40:58 clr-01 kata-runtime[5392]: time="2019-01-03T17:40:58.995044522Z" level=info msg="endpoint unmarshalled" arch=amd64 command=start container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc000500480] [0xc000500488]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc00034c0c0 0 0xc000425d20 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5392 source=virtcontainers subsystem=network

Jan 03 17:40:58 clr-01 kata-runtime[5392]: time="2019-01-03T17:40:58.995941589Z" level=info msg="release sandbox" arch=amd64 command=start container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5392 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:40:58 clr-01 kata-runtime[5392]: time="2019-01-03T17:40:58.99668192Z" level=info msg="fetch sandbox" arch=amd64 command=start container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5392 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers

Jan 03 17:40:58 clr-01 kata-runtime[5392]: time="2019-01-03T17:40:58.999748235Z" level=info msg="endpoint unmarshalled" arch=amd64 command=start container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc0005006c8] [0xc0005006d0]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc00034c300 0 0xc000316fa0 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5392 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=network

Jan 03 17:40:59 clr-01 kata-runtime[5392]: time="2019-01-03T17:40:59.000243572Z" level=info msg="New client" arch=amd64 command=start container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5392 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:40:59 clr-01 kata-runtime[5392]: time="2019-01-03T17:40:59.04222433Z" level=info msg="Sandbox is started" arch=amd64 command=start container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5392 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:40:59 clr-01 kata-runtime[5392]: time="2019-01-03T17:40:59.042319981Z" level=info msg="release sandbox" arch=amd64 command=start container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5392 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:40:59 clr-01 kata-runtime[5412]: time="2019-01-03T17:40:59.088244328Z" level=info msg="loaded configuration" arch=amd64 command=state file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5412 source=katautils

Jan 03 17:40:59 clr-01 kata-runtime[5412]: time="2019-01-03T17:40:59.088403771Z" level=info arch=amd64 arguments="\"state e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b\""command=state commit= name=kata-runtime pid=5412 source=runtime version=1.5.0-rc2

Jan 03 17:40:59 clr-01 kata-runtime[5412]: time="2019-01-03T17:40:59.088513319Z" level=info msg="fetch sandbox" arch=amd64 command=state container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5412 source=virtcontainers

Jan 03 17:40:59 clr-01 kata-runtime[5412]: time="2019-01-03T17:40:59.091264782Z" level=info msg="endpoint unmarshalled" arch=amd64 command=state container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc0005702a0] [0xc0005702a8]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc000328000 0 0xc000367780 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5412 source=virtcontainers subsystem=network

Jan 03 17:40:59 clr-01 kata-runtime[5412]: time="2019-01-03T17:40:59.091778445Z" level=info msg="release sandbox" arch=amd64 command=state container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5412 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:03 clr-01 kubelet[24089]: W0103 17:41:03.216761   24089 cpu_manager.go:236] [cpumanager] reconcileState: skipping container; ID not found in status (pod: test-cpumanager-kata, container: taskset, error: unable to find ID for container with name taskset in pod status (it may not be running))

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.659906187Z" level=info msg="loaded configuration" arch=amd64 command=create file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5633 source=katautils

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.660107068Z" level=info arch=amd64 arguments="\"create --bundle /var/run/containers/storage/overlay-containers/508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf/userdata --pid-file /var/run/containers/storage/overlay-containers/508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf/userdata/pidfile 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf\"" command=create commit= name=kata-runtime pid=5633 source=runtime version=1.5.0-rc2

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.66175045Z" level=info msg="fetch sandbox" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.665100528Z" level=info msg="endpoint unmarshalled" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc000588e48] [0xc000588e50]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc0003d0000 0 0xc0000c4460 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil>Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5633 source=virtcontainers subsystem=network

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.666136083Z" level=info msg="{\"QMP\": {\"version\": {\"qemu\": {\"micro\": 0, \"minor\": 11, \"major\": 2}, \"package\":\"\"}, \"capabilities\": []}}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.66641498Z" level=info msg="{\"execute\":\"qmp_capabilities\"}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.667323245Z" level=info msg="{\"return\": {}}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.667779265Z" level=info msg="{\"execute\":\"query-hotpluggable-cpus\"}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.669069857Z" level=info msg="{\"return\": [{\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 15}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 14}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 13}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 12}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 11}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 10}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0,\"thread-id\": 0, \"node-id\": 0, \"socket-id\": 9}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 8}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 7}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 6}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0,\"socket-id\": 5}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 4}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 3}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 2}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 1}, \"vcpus-count\": 1, \"type\": \"host-x86_64-cpu\"}, {\"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 0}, \"vcpus-count\": 1, \"qom-path\": \"/machine/unattached/device[0]\", \"type\": \"host-x86_64-cpu\"}]}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.671355447Z" level=info msg="{\"arguments\":{\"core-id\":\"0\",\"driver\":\"host-x86_64-cpu\",\"id\":\"cpu-0\",\"socket-id\":\"15\",\"thread-id\":\"0\"},\"execute\":\"device_add\"}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.677533469Z" level=info msg="{\"return\": {}}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.678228184Z" level=info msg="New client" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.681466847Z" level=info msg="{\"timestamp\": {\"seconds\": 1546537263, \"microseconds\": 681221}, \"event\": \"ACPI_DEVICE_OST\", \"data\": {\"info\": {\"device\": \"cpu-0\", \"source\": 1, \"status\": 0, \"slot\": \"15\", \"slot-type\": \"CPU\"}}}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.689696802Z" level=info msg="{\"execute\":\"query-memory-devices\"}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.69140623Z" level=info msg="{\"return\": [{\"type\": \"dimm\", \"data\": {\"memdev\": \"/objects/mem0\", \"hotplugged\": false, \"addr\": 4294967296, \"hotpluggable\": true, \"size\": 536870912, \"slot\": 0, \"node\": 0, \"id\": \"nv0\"}}]}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.691898317Z" level=info msg="{\"arguments\":{\"id\":\"mem1\",\"props\":{\"size\":536870912},\"qom-type\":\"memory-backend-ram\"},\"execute\":\"object-add\"}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.694689691Z" level=info msg="{\"return\": {}}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.694922242Z" level=info msg="{\"arguments\":{\"driver\":\"pc-dimm\",\"id\":\"dimmmem1\",\"memdev\":\"mem1\"},\"execute\":\"device_add\"}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.703607366Z" level=info msg="{\"return\": {}}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.704018497Z" level=info msg="New client" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.730116108Z" level=info msg="device details" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf device-major=0 device-minor=180 mount-point=/var/lib/containers/storage/overlay/64a28a0e2cb6d823153a4226446955c21cdc57b86adb95a740ed80ec375541f6/merged name=kata-runtime pid=5633 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=container

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.732913284Z" level=info msg="Using sandbox shm" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 shm-size=67108864 source=virtcontainers subsystem=kata_agent

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.732995396Z" level=info msg="New client" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.736493469Z" level=info msg="{\"timestamp\": {\"seconds\": 1546537263, \"microseconds\": 736287}, \"event\": \"ACPI_DEVICE_OST\", \"data\": {\"info\": {\"device\": \"dimmmem1\", \"source\": 1, \"status\": 0, \"slot\": \"1\", \"slot-type\": \"DIMM\"}}}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.859221971Z" level=info msg="{\"execute\":\"query-cpus\"}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.861969411Z" level=info msg="{\"return\": [{\"arch\": \"x86\", \"current\": true, \"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 0}, \"CPU\": 0, \"qom_path\": \"/machine/unattached/device[0]\", \"pc\": -2124175454, \"halted\": true, \"thread_id\": 5356}, {\"arch\": \"x86\", \"current\": false, \"props\": {\"core-id\": 0, \"thread-id\": 0, \"node-id\": 0, \"socket-id\": 15}, \"CPU\": 15, \"qom_path\": \"/machine/peripheral/cpu-0\", \"pc\": -2124175454, \"halted\": true, \"thread_id\": 5652}]}" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 source=virtcontainers subsystem=qmp

Jan 03 17:41:03 clr-01 kata-runtime[5633]: time="2019-01-03T17:41:03.864218218Z" level=info msg="release sandbox" arch=amd64 command=create container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5633 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:03 clr-01 kata-runtime[5681]: time="2019-01-03T17:41:03.91141581Z" level=info msg="loaded configuration" arch=amd64 command=state file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5681 source=katautils

Jan 03 17:41:03 clr-01 kata-runtime[5681]: time="2019-01-03T17:41:03.911594794Z" level=info arch=amd64 arguments="\"state 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf\""command=state commit= name=kata-runtime pid=5681 source=runtime version=1.5.0-rc2

Jan 03 17:41:03 clr-01 kata-runtime[5681]: time="2019-01-03T17:41:03.91171852Z" level=info msg="fetch sandbox" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5681 source=virtcontainers

Jan 03 17:41:03 clr-01 kata-runtime[5681]: time="2019-01-03T17:41:03.914828057Z" level=info msg="endpoint unmarshalled" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc0000c8410] [0xc0000c8418]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc0005300c0 0 0xc0003175a0 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5681 source=virtcontainers subsystem=network

Jan 03 17:41:03 clr-01 kata-runtime[5681]: time="2019-01-03T17:41:03.915513277Z" level=info msg="release sandbox" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5681 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:03 clr-01 kubelet[24089]: I0103 17:41:03.929796   24089 policy_static.go:175] [cpumanager] static policy: AddContainer (pod: test-cpumanager-kata, container: taskset, containerid: 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf)

Jan 03 17:41:03 clr-01 kubelet[24089]: I0103 17:41:03.929841   24089 policy_static.go:205] [cpumanager] allocateCpus: (numCPUs: 1)

Jan 03 17:41:03 clr-01 kubelet[24089]: I0103 17:41:03.929967   24089 state_mem.go:84] [cpumanager] updated default cpuset: "0,2-15"

Jan 03 17:41:03 clr-01 kubelet[24089]: I0103 17:41:03.931769   24089 policy_static.go:213] [cpumanager] allocateCPUs: returning "1"

Jan 03 17:41:03 clr-01 kubelet[24089]: I0103 17:41:03.931804   24089 state_mem.go:76] [cpumanager] updated desired cpuset (container id: 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf, cpuset: "1")

Jan 03 17:41:03 clr-01 kata-runtime[5716]: time="2019-01-03T17:41:03.991496338Z" level=info msg="loaded configuration" arch=amd64 command=update file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5716 source=katautils

Jan 03 17:41:03 clr-01 kata-runtime[5716]: time="2019-01-03T17:41:03.991754715Z" level=info arch=amd64 arguments="\"update --resources - 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf\"" command=update commit= name=kata-runtime pid=5716 source=runtime version=1.5.0-rc2

Jan 03 17:41:03 clr-01 kata-runtime[5716]: time="2019-01-03T17:41:03.991985375Z" level=info msg="fetch sandbox" arch=amd64 command=update container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5716 source=virtcontainers

Jan 03 17:41:03 clr-01 kata-runtime[5716]: time="2019-01-03T17:41:03.996074417Z" level=info msg="endpoint unmarshalled" arch=amd64 command=update container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc0004e83c8] [0xc0004e83d0]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc00036a180 0 0xc0002f2320 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil>Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5716 source=virtcontainers subsystem=network

Jan 03 17:41:03 clr-01 kata-runtime[5716]: time="2019-01-03T17:41:03.996725033Z" level=info msg="release sandbox" arch=amd64 command=update container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5716 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:03 clr-01 kata-runtime[5716]: time="2019-01-03T17:41:03.996812511Z" level=error msg="Container 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf is not running" arch=amd64 command=update container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5716 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=runtime

Jan 03 17:41:03 clr-01 kubelet[24089]: E0103 17:41:03.999389   24089 remote_runtime.go:306] UpdateContainerResources "508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf" from runtime service failed: rpc error: code = Unknown desc = updating resources for container "508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf" failed: Container 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf is not running

Jan 03 17:41:03 clr-01 kubelet[24089]:   (exit status 1)

Jan 03 17:41:03 clr-01 kubelet[24089]: E0103 17:41:03.999471   24089 cpu_manager.go:183] [cpumanager] AddContainer error: rpc error: code = Unknown desc = updating resources for container "508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf" failed: Container 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf is not running

Jan 03 17:41:03 clr-01 kubelet[24089]:   (exit status 1)

Jan 03 17:41:03 clr-01 kubelet[24089]: I0103 17:41:03.999503   24089 policy_static.go:195] [cpumanager] static policy: RemoveContainer (container id: 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf)

Jan 03 17:41:04 clr-01 kubelet[24089]: I0103 17:41:04.001523   24089 state_mem.go:84] [cpumanager] updated default cpuset: "0-15"

Jan 03 17:41:04 clr-01 kubelet[24089]: E0103 17:41:04.003408   24089 kuberuntime_manager.go:749] container start failed: PreStartHookError: updating resources for container "508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf" failed: Container 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf is not running

Jan 03 17:41:04 clr-01 kubelet[24089]:   (exit status 1)

Jan 03 17:41:04 clr-01 kubelet[24089]: E0103 17:41:04.003559   24089 pod_workers.go:190] Error syncing pod b91bd72c-0f7e-11e9-a5de-5254003ca334 ("test-cpumanager-kata_default(b91bd72c-0f7e-11e9-a5de-5254003ca334)"), skipping: failed to "StartContainer" for "taskset" with PreStartHookError: "updating resources for container \"508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf\" failed: Container 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf is not running\n  (exit status 1)"

Jan 03 17:41:04 clr-01 systemd-timesyncd[20861]: Timed out waiting for reply from 199.102.46.77:123 (2.clearlinux.pool.ntp.org).

Jan 03 17:41:04 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:04.879221098Z" level=info msg="loaded configuration" arch=amd64 command=kill file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5735 source=katautils

Jan 03 17:41:04 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:04.879417333Z" level=info arch=amd64 arguments="\"kill 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf TERM\"" command=kill commit= name=kata-runtime pid=5735 source=runtime version=1.5.0-rc2

Jan 03 17:41:04 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:04.879570797Z" level=info msg="fetch sandbox" arch=amd64 command=kill container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5735 source=virtcontainers

Jan 03 17:41:04 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:04.8830711Z" level=info msg="endpoint unmarshalled" arch=amd64 command=kill container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc00000e418] [0xc00000e420]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc0001ec0c0 0 0xc000367420 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64][{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw:<nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5735 source=virtcontainers subsystem=network

Jan 03 17:41:04 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:04.883830251Z" level=info msg="release sandbox" arch=amd64 command=kill container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5735 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:04 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:04.883926032Z" level=info msg="fetch sandbox" arch=amd64 command=kill container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5735 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers

Jan 03 17:41:04 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:04.886534501Z" level=info msg="endpoint unmarshalled" arch=amd64 command=kill container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc00000e640] [0xc00000e648]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc0001ec300 0 0xc0002582e0 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5735 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=network

Jan 03 17:41:04 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:04.887153698Z" level=info msg="New client" arch=amd64 command=kill container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5735 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:41:04 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:04.893507903Z" level=info msg="release sandbox" arch=amd64 command=kill container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5735 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:04 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:04.893621416Z" level=info msg="fetch sandbox" arch=amd64 command=kill container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5735 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers

Jan 03 17:41:04 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:04.897885523Z" level=info msg="endpoint unmarshalled" arch=amd64 command=kill container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc00059e160] [0xc00059e168]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc000368180 0 0xc000402860 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5735 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=network

Jan 03 17:41:04 clr-01 kubelet[24089]: I0103 17:41:04.945422   24089 reconciler.go:181] operationExecutor.UnmountVolume started for volume "default-token-8w8x5" (UniqueName: "kubernetes.io/secret/b91bd72c-0f7e-11e9-a5de-5254003ca334-default-token-8w8x5") pod "b91bd72c-0f7e-11e9-a5de-5254003ca334" (UID: "b91bd72c-0f7e-11e9-a5de-5254003ca334")

Jan 03 17:41:04 clr-01 kubelet[24089]: I0103 17:41:04.959247   24089 operation_generator.go:683] UnmountVolume.TearDown succeeded for volume "kubernetes.io/secret/b91bd72c-0f7e-11e9-a5de-5254003ca334-default-token-8w8x5" (OuterVolumeSpecName: "default-token-8w8x5") pod "b91bd72c-0f7e-11e9-a5de-5254003ca334" (UID: "b91bd72c-0f7e-11e9-a5de-5254003ca334"). InnerVolumeSpecName "default-token-8w8x5". PluginName "kubernetes.io/secret", VolumeGidValue ""

Jan 03 17:41:04 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:04.998927556Z" level=info msg="New client" arch=amd64 command=kill container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5735 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:41:05 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:05.003583408Z" level=info msg="New client" arch=amd64 command=kill container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5735 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:41:05 clr-01 kubelet[24089]: E0103 17:41:05.003974   24089 handler.go:306] HTTP InternalServerError serving /stats/summary: Internal Error: failed to get imageFs stats: failed to get imageFs info: no imagefs label for configured runtime

Jan 03 17:41:05 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:05.0095065Z" level=info msg="New client" arch=amd64 command=kill container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5735 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:41:05 clr-01 kubelet[24089]: I0103 17:41:05.045936   24089 reconciler.go:301] Volume detached for volume "default-token-8w8x5" (UniqueName: "kubernetes.io/secret/b91bd72c-0f7e-11e9-a5de-5254003ca334-default-token-8w8x5") on node "clr-01" DevicePath ""

Jan 03 17:41:05 clr-01 kata-runtime[5735]: time="2019-01-03T17:41:05.082367907Z" level=info msg="release sandbox" arch=amd64 command=kill container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5735 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:05 clr-01 kata-runtime[5756]: time="2019-01-03T17:41:05.137946917Z" level=info msg="loaded configuration" arch=amd64 command=state file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5756 source=katautils

Jan 03 17:41:05 clr-01 kata-runtime[5756]: time="2019-01-03T17:41:05.138110163Z" level=info arch=amd64 arguments="\"state 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf\""command=state commit= name=kata-runtime pid=5756 source=runtime version=1.5.0-rc2

Jan 03 17:41:05 clr-01 kata-runtime[5756]: time="2019-01-03T17:41:05.138230322Z" level=info msg="fetch sandbox" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5756 source=virtcontainers

Jan 03 17:41:05 clr-01 kata-runtime[5756]: time="2019-01-03T17:41:05.141601721Z" level=info msg="endpoint unmarshalled" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc0004fa2b0] [0xc0004fa2b8]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc0003e80c0 0 0xc000367400 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5756 source=virtcontainers subsystem=network

Jan 03 17:41:05 clr-01 kata-runtime[5756]: time="2019-01-03T17:41:05.142310766Z" level=info msg="release sandbox" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5756 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:05 clr-01 kata-runtime[5771]: time="2019-01-03T17:41:05.197626339Z" level=info msg="loaded configuration" arch=amd64 command=state file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5771 source=katautils

Jan 03 17:41:05 clr-01 kata-runtime[5771]: time="2019-01-03T17:41:05.197819773Z" level=info arch=amd64 arguments="\"state 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf\""command=state commit= name=kata-runtime pid=5771 source=runtime version=1.5.0-rc2

Jan 03 17:41:05 clr-01 kata-runtime[5771]: time="2019-01-03T17:41:05.197947054Z" level=info msg="fetch sandbox" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5771 source=virtcontainers

Jan 03 17:41:05 clr-01 kata-runtime[5771]: time="2019-01-03T17:41:05.201205293Z" level=info msg="endpoint unmarshalled" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc00000e418] [0xc00000e420]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc00021c0c0 0 0xc00036bc20 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5771 source=virtcontainers subsystem=network

Jan 03 17:41:05 clr-01 kata-runtime[5771]: time="2019-01-03T17:41:05.201990797Z" level=info msg="release sandbox" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5771 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:05 clr-01 kata-runtime[5786]: time="2019-01-03T17:41:05.255549343Z" level=info msg="loaded configuration" arch=amd64 command=state file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5786 source=katautils

Jan 03 17:41:05 clr-01 kata-runtime[5786]: time="2019-01-03T17:41:05.255709165Z" level=info arch=amd64 arguments="\"state 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf\""command=state commit= name=kata-runtime pid=5786 source=runtime version=1.5.0-rc2

Jan 03 17:41:05 clr-01 kata-runtime[5786]: time="2019-01-03T17:41:05.255853041Z" level=info msg="fetch sandbox" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5786 source=virtcontainers

Jan 03 17:41:05 clr-01 kata-runtime[5786]: time="2019-01-03T17:41:05.259806548Z" level=info msg="endpoint unmarshalled" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc0000c85b8] [0xc0000c85c0]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc0003c2180 0 0xc000316e40 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5786 source=virtcontainers subsystem=network

Jan 03 17:41:05 clr-01 kata-runtime[5786]: time="2019-01-03T17:41:05.260507863Z" level=info msg="release sandbox" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5786 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:05 clr-01 kata-runtime[5799]: time="2019-01-03T17:41:05.313438972Z" level=info msg="loaded configuration" arch=amd64 command=state file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5799 source=katautils

Jan 03 17:41:05 clr-01 kata-runtime[5799]: time="2019-01-03T17:41:05.313615788Z" level=info arch=amd64 arguments="\"state 508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf\""command=state commit= name=kata-runtime pid=5799 source=runtime version=1.5.0-rc2

Jan 03 17:41:05 clr-01 kata-runtime[5799]: time="2019-01-03T17:41:05.313765199Z" level=info msg="fetch sandbox" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5799 source=virtcontainers

Jan 03 17:41:05 clr-01 kata-runtime[5799]: time="2019-01-03T17:41:05.317150011Z" level=info msg="endpoint unmarshalled" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc00000e518] [0xc00000e520]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc00034a180 0 0xc0002f2320 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5799 source=virtcontainers subsystem=network

Jan 03 17:41:05 clr-01 kata-runtime[5799]: time="2019-01-03T17:41:05.317871148Z" level=info msg="release sandbox" arch=amd64 command=state container=508b47a7c5cc51f3ac345902e7ce9f7111bb7c038780ae8437014b1f11b0eedf name=kata-runtime pid=5799 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:05 clr-01 kernel: calling  nf_nat_l3proto_ipv6_init+0x0/0x1000 [nf_nat_ipv6] @ 5823

Jan 03 17:41:05 clr-01 kernel: initcall nf_nat_l3proto_ipv6_init+0x0/0x1000 [nf_nat_ipv6] returned 0 after 1 usecs

Jan 03 17:41:05 clr-01 kernel: calling  ip6table_nat_init+0x0/0x1000 [ip6table_nat] @ 5823

Jan 03 17:41:05 clr-01 kernel: initcall ip6table_nat_init+0x0/0x1000 [ip6table_nat] returned 0 after 971 usecs

Jan 03 17:41:05 clr-01 crio[22892]: 2019-01-03 17:41:05.399 [INFO][5838] calico.go 442: Extracted identifiers ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b" Node="clr-01" Orchestrator="k8s" WorkloadEndpoint="clr--01-k8s-test--cpumanager--kata-eth0"

Jan 03 17:41:05 clr-01 crio[22892]: 2019-01-03 17:41:05.409 [WARNING][5838] workloadendpoint.go 70: Operation Delete is not supported on WorkloadEndpoint type

Jan 03 17:41:05 clr-01 crio[22892]: 2019-01-03 17:41:05.409 [INFO][5838] k8s.go 474: Endpoint deletion will be handled by Kubernetes deletion of the Pod. ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b" endpoint=&v3.WorkloadEndpoint{TypeMeta:v1.TypeMeta{Kind:"WorkloadEndpoint", APIVersion:"projectcalico.org/v3"}, ObjectMeta:v1.ObjectMeta{Name:"clr--01-k8s-test--cpumanager--kata-eth0", GenerateName:"", Namespace:"default", SelfLink:"", UID:"b91bd72c-0f7e-11e9-a5de-5254003ca334", ResourceVersion:"1652", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63682134055, loc:(*time.Location)(0x1edd720)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"projectcalico.org/namespace":"default", "projectcalico.org/orchestrator":"k8s", "projectcalico.org/serviceaccount":"default"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string(nil), ClusterName:""}, Spec:v3.WorkloadEndpointSpec{Orchestrator:"k8s", Workload:"", Node:"clr-01", ContainerID:"", Pod:"test-cpumanager-kata", Endpoint:"eth0", IPNetworks:[]string{"10.244.0.5/32"}, IPNATs:[]v3.IPNAT(nil), IPv4Gateway:"", IPv6Gateway:"", Profiles:[]string{"kns.default", "ksa.default.default"}, InterfaceName:"calid51be51c92d", MAC:"", Ports:[]v3.EndpointPort(nil)}}

Jan 03 17:41:05 clr-01 crio[22892]: 2019-01-03 17:41:05.409 [INFO][5838] k8s.go 481: Releasing IP address(es) ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b"

Jan 03 17:41:05 clr-01 crio[22892]: Calico CNI releasing IP address

Jan 03 17:41:05 clr-01 crio[22892]: 2019-01-03 17:41:05.409 [INFO][5838] utils.go 163: Using a dummy podCidr to release the IP ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b" podCidr="0.0.0.0/0"

Jan 03 17:41:05 clr-01 crio[22892]: Calico CNI fetching podCidr from Kubernetes

Jan 03 17:41:05 clr-01 crio[22892]: 2019-01-03 17:41:05.409 [INFO][5838] utils.go 261: Fetched podCidr ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b" podCidr="0.0.0.0/0"

Jan 03 17:41:05 clr-01 crio[22892]: Calico CNI passing podCidr to host-local IPAM: 0.0.0.0/0

Jan 03 17:41:05 clr-01 crio[22892]: 2019-01-03 17:41:05.412 [INFO][5838] k8s.go 485: Cleaning up netns ContainerID="e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b"

Jan 03 17:41:05 clr-01 crio[22892]: Calico CNI deleting device in netns /var/run/netns/k8s_test-cpumanager-kata_default_b91bd72c-0f7e-11e9-a5de-5254003ca334_0-b96c8d18

Jan 03 17:41:05 clr-01 crio[22892]: time="2019-01-03 17:41:05.415352712Z" level=error msg="Error deleting network: failed to get IP addresses for "eth0": <nil>"

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.460274861Z" level=info msg="loaded configuration" arch=amd64 command=kill file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5859 source=katautils

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.460434298Z" level=info arch=amd64 arguments="\"kill e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b TERM\"" command=kill commit= name=kata-runtime pid=5859 source=runtime version=1.5.0-rc2

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.460545621Z" level=info msg="fetch sandbox" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 source=virtcontainers

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.463714579Z" level=info msg="endpoint unmarshalled" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc00000e2c0] [0xc00000e2c8]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc0001000c0 0 0xc000313cc0 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5859 source=virtcontainers subsystem=network

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.464406206Z" level=info msg="release sandbox" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120[50/4766]64d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.464483732Z" level=info msg="fetch sandbox" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.466905606Z" level=info msg="endpoint unmarshalled" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc00000e4e8] [0xc00000e4f0]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc000100300 0 0xc000036600 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=network

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.467468004Z" level=info msg="New client" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.474795887Z" level=info msg="release sandbox" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.475302485Z" level=info msg="fetch sandbox" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.479220419Z" level=info msg="endpoint unmarshalled" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc0000c61a0] [0xc0000c61a8]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc0001000c0 0 0xc0005a8820 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=network

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.580112835Z" level=info msg="New client" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.584688156Z" level=info msg="New client" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.587821248Z" level=info msg="New client" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.632184313Z" level=info msg="Container already stopped" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=container

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.632297408Z" level=info msg="New client" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=kata_agent url="unix:///run/vc/sbs/e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b/proxy.sock"

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.653777253Z" level=info msg="Stopping VM" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.653871695Z" level=info msg="Stopping Sandbox" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=qemu

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.65436046Z" level=info msg="{\"QMP\": {\"version\": {\"qemu\": {\"micro\": 0, \"minor\": 11, \"major\": 2}, \"package\": \"\"}, \"capabilities\": []}}" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=qmp

Jan 03 17:41:05 clr-01 kata-proxy[5362]: time="2019-01-03T17:41:05.654297665Z" level=fatal msg="failed to handle exit signal" error="close unix @->/run/vc/vm/e29f41718a9e7c9c1ba9ac61[6/4766]0dcd28f7e764d78756d8a163e8c5833b/kata.sock: use of closed network connection" name=kata-proxy pid=5362 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=proxy

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.655475351Z" level=info msg="{\"execute\":\"qmp_capabilities\"}" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=qmp

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.656835833Z" level=info msg="{\"return\": {}}" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=qmp

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.657161227Z" level=info msg="{\"execute\":\"quit\"}" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=qmp

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.657795374Z" level=info msg="{\"return\": {}}" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=qmp

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.6579095Z" level=info msg="{\"timestamp\": {\"seconds\": 1546537265, \"microseconds\": 657669}, \"event\": \"SHUTDOWN\", \"data\": {\"guest\": false}}" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=qmp

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.658285767Z" level=info msg="Detaching endpoint" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b endpoint-type=virtual hotunplug=false name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=default-network

Jan 03 17:41:05 clr-01 kata-runtime[5859]: time="2019-01-03T17:41:05.658388731Z" level=info msg="release sandbox" arch=amd64 command=kill container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5859 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:05 clr-01 kata-runtime[5880]: time="2019-01-03T17:41:05.70930231Z" level=info msg="loaded configuration" arch=amd64 command=state file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5880 source=katautils

Jan 03 17:41:05 clr-01 kata-runtime[5880]: time="2019-01-03T17:41:05.709466287Z" level=info arch=amd64 arguments="\"state e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b\""command=state commit= name=kata-runtime pid=5880 source=runtime version=1.5.0-rc2

Jan 03 17:41:05 clr-01 kata-runtime[5880]: time="2019-01-03T17:41:05.709582807Z" level=info msg="fetch sandbox" arch=amd64 command=state container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5880 source=virtcontainers

Jan 03 17:41:05 clr-01 kata-runtime[5880]: time="2019-01-03T17:41:05.712690604Z" level=info msg="endpoint unmarshalled" arch=amd64 command=state container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc00000e2b8] [0xc00000e2c0]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc0002360c0 0 0xc000391600 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5880 source=virtcontainers subsystem=network

Jan 03 17:41:05 clr-01 kata-runtime[5880]: time="2019-01-03T17:41:05.713404998Z" level=info msg="release sandbox" arch=amd64 command=state container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5880 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:05 clr-01 kata-runtime[5898]: time="2019-01-03T17:41:05.769945806Z" level=info msg="loaded configuration" arch=amd64 command=state file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5898 source=katautils

Jan 03 17:41:05 clr-01 kata-runtime[5898]: time="2019-01-03T17:41:05.770095386Z" level=info arch=amd64 arguments="\"state e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b\""command=state commit= name=kata-runtime pid=5898 source=runtime version=1.5.0-rc2

Jan 03 17:41:05 clr-01 kata-runtime[5898]: time="2019-01-03T17:41:05.770207179Z" level=info msg="fetch sandbox" arch=amd64 command=state container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5898 source=virtcontainers

Jan 03 17:41:05 clr-01 kata-runtime[5898]: time="2019-01-03T17:41:05.773333588Z" level=info msg="endpoint unmarshalled" arch=amd64 command=state container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc00000e460] [0xc00000e468]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc00035e180 0 0xc0004255e0 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5898 source=virtcontainers subsystem=network

Jan 03 17:41:05 clr-01 kata-runtime[5898]: time="2019-01-03T17:41:05.774020373Z" level=info msg="release sandbox" arch=amd64 command=state container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5898 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:05 clr-01 kernel: device eth0 left promiscuous mode

Jan 03 17:41:05 clr-01 systemd-networkd[10388]: calid51be51c92d: Lost carrier

Jan 03 17:41:05 clr-01 kata-runtime[5912]: time="2019-01-03T17:41:05.824956459Z" level=info msg="loaded configuration" arch=amd64 command=state file=/usr/share/defaults/kata-containers/configuration.toml format=TOML name=kata-runtime pid=5912 source=katautils

Jan 03 17:41:05 clr-01 kata-runtime[5912]: time="2019-01-03T17:41:05.825112855Z" level=info arch=amd64 arguments="\"state e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b\""command=state commit= name=kata-runtime pid=5912 source=runtime version=1.5.0-rc2

Jan 03 17:41:05 clr-01 kata-runtime[5912]: time="2019-01-03T17:41:05.825215467Z" level=info msg="fetch sandbox" arch=amd64 command=state container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5912 source=virtcontainers

Jan 03 17:41:05 clr-01 kata-runtime[5912]: time="2019-01-03T17:41:05.828341611Z" level=info msg="endpoint unmarshalled" arch=amd64 command=state container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b endpoint="{{{c39852ab-a14c-40bd-84cf-590017fcd7b0 br0_kata {tap0_kata 46:40:30:22:10:8d []} [0xc0004f02b0] [0xc0004f02b8]} {eth0 2e:01:4a:82:78:ac [10.244.0.5/32 eth0]} 2} {{{3 1500 0 eth0 46:40:30:22:10:8d up|broadcast|multicast 69699 8 0 <nil>  0xc0003240c0 0 0xc000391380 ether <nil> up 0 0 0} veth} [10.244.0.5/32 eth0 fe80::4440:30ff:fe22:108d/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 169.254.1.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 169.254.1.1/32 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: ff00::/8 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual }" endpoint-type=virtual name=kata-runtime pid=5912 source=virtcontainers subsystem=network

Jan 03 17:41:05 clr-01 kata-runtime[5912]: time="2019-01-03T17:41:05.829145277Z" level=info msg="release sandbox" arch=amd64 command=state container=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b name=kata-runtime pid=5912 sandbox=e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b source=virtcontainers subsystem=sandbox

Jan 03 17:41:05 clr-01 kubelet[24089]: W0103 17:41:05.844378   24089 pod_container_deletor.go:75] Container "e29f41718a9e7c9c1ba9ac61869686120dcd28f7e764d78756d8a163e8c5833b" not found in pod's containers