Skip to content
This repository has been archived by the owner on May 12, 2021. It is now read-only.

cli: Don't wait for OCI delete to stop the sandbox #232

Merged
merged 2 commits into from
Apr 26, 2018

Conversation

sboeuf
Copy link

@sboeuf sboeuf commented Apr 19, 2018

This commit tries to address uses cases where the caller of the
runtime expects a kill to stop the container representing the pod,
meaning in our case the end of the VM.

This leads to some rework of the delete command since we want a
delete --force to always work, even if the container/pod has been
killed before.

Fixes #197

Signed-off-by: Sebastien Boeuf [email protected]

@sboeuf
Copy link
Author

sboeuf commented Apr 19, 2018

@chavafg could you please try this patch with both openshift and k8s, it should fix the common issue that we have about the pod that cannot be deleted.

cli/delete.go Outdated
if _, err := vci.StopSandbox(sandboxID); err != nil {
return err
func deleteSandbox(sandboxID, containerID string, forceStop bool) error {
if forceStop {
Copy link
Contributor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

This seems like a fairly fundamental change so I was expecting to see some new/modified tests for this...?

Copy link
Author

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Yes but I need to make sure this is the right thing to do and it fixes all issues before I spend some time on those tests.

Copy link
Contributor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

@sboeuf - in which case, I wonder if @grahamwhaley's soak test could help us in this regard?

Copy link
Author

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

I have in mind a more global PR. I am currently working on #213 (the unit tests are a nightmare...), but I hope I can update this one tomorrow.

Copy link
Contributor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

For the soak test, we should look at kata-containers/tests#195 or maybe preferably kata-containers/tests#215 to add that ability/check to kata.

@chavafg
Copy link
Contributor

chavafg commented Apr 20, 2018

Hi @sboeuf
I am still checking this. The issues on openshift disappear, but on k8s I still have some similar issues, I am debugging and will paste more information once I have it.

@chavafg
Copy link
Contributor

chavafg commented Apr 20, 2018

I see 2 kata-runtime errors when running kubectl delete deployment, one regarding networking:
Errors:

Apr 20 13:49:43 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:43.046385153Z" level=error msg="rpc error: code = Internal desc = Could not remove network route dest:\"10.244.0.0/16\" gateway:\"10.244.
0.1\" device:\"eth0\" : rpc error: code = Internal desc = Could not remove route dest(10.244.0.0/16)/gw(10.244.0.1)/dev(eth0): no such process" command=kill name=kata-runtime pid=39205 source=runtime
Apr 20 13:50:26 openshift-fix kata-runtime[39397]: time="2018-04-20T13:50:26.257210268Z" level=error msg="Sandbox not ready, paused or stopped, impossible to delete" command=delete name=kata-runtime pid=39397 source=runtime

Container ID:
b3177caca69e3f640d7b08e1b622fce1486429a5cddfd46b3d6bedfb2a304365

Pod ID:
c5777808b4fbb86bd9a0aed4bea6ccd7b00c6947a597ecf829c3996257e90ce3

Full log:

Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.214796518Z" level=debug msg="loaded configuration" command=kill format=TOML name=kata-runtime pid=39135 source=runtime
Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.215271622Z" level=info arguments="\"kill b3177caca69e3f640d7b08e1b622fce1486429a5cddfd46b3d6bedfb2a304365 TERM\"" command=kill commit=3dd37470b0f03ed8fd65bb79a5b684a7e47e5369 name=kata-runtime pid=39135 source=runtime version=0.0.1
Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.220023656Z" level=info msg="Virtual endpoint unmarshalled [{{eb091a44-b5c0-4c6b-a693-4c48b54412fa br0 {eth0 02:00:ca:fe:00:00 [10.244.0.2/24 eth0]} {tap0 0a:58:0a:f4:00:02 []} 2 [0xc4201b2158 0xc4201b2168 0xc4201b2170 0xc4201b2178 0xc4201b2180 0xc4201b2188 0xc4201b2190 0xc4201b2198] [0xc4201b21a0 0xc4201b21a8 0xc4201b21b0 0xc4201b21b8 0xc4201b21c0 0xc4201b21c8 0xc4201b21d0 0xc4201b21d8]} {{{3 1450 0 eth0 0a:58:0a:f4:00:02 up|broadcast|multicast 69699 67 0 <nil>  0xc420244240 0 0xc420197dc0 ether <nil> up 0 0 0} veth} [10.244.0.2/24 eth0 fe80::d8f7:50ff:fe41:f5b3/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.2 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39135 source=virtcontainers
Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.222778876Z" level=info msg="Virtual endpoint unmarshalled [{{a3646dcb-f0b6-4192-8ec5-032003d81994 br0 {eth0 02:00:ca:fe:00:00 [10.244.0.3/24 eth0]} {tap0 0a:58:0a:f4:00:03 []} 2 [0xc4201b2308 0xc4201b2310 0xc4201b2318 0xc4201b2320 0xc4201b2328 0xc4201b2330 0xc4201b2338 0xc4201b2340] [0xc4201b2348 0xc4201b2350 0xc4201b2358 0xc4201b2360 0xc4201b2368 0xc4201b2370 0xc4201b2378 0xc4201b2380]} {{{3 1450 0 eth0 0a:58:0a:f4:00:03 up|broadcast|multicast 69699 68 0 <nil>  0xc420244600 0 0xc4202848c0 ether <nil> up 0 0 0} veth} [10.244.0.3/24 eth0 fe80::b408:87ff:fe33:9723/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.3 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39135 source=virtcontainers
Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.547421732Z" level=info msg="unplugging block device" arch=amd64 container-id=b3177caca69e3f640d7b08e1b622fce1486429a5cddfd46b3d6bedfb2a304365 name=kata-runtime pid=39135 sandbox-id=c5777808b4fbb86bd9a0aed4bea6ccd7b00c6947a597ecf829c3996257e90ce3 source=virtcontainers subsystem=container
Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.547607634Z" level=info msg="Unplugging block device" arch=amd64 container-id=b3177caca69e3f640d7b08e1b622fce1486429a5cddfd46b3d6bedfb2a304365 device-id=drive-b3177caca69e3f640d7b08e1b name=kata-runtime pid=39135 sandbox-id=c5777808b4fbb86bd9a0aed4bea6ccd7b00c6947a597ecf829c3996257e90ce3 source=virtcontainers subsystem=container
Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.548050037Z" level=info msg="{\"QMP\": {\"version\": {\"qemu\": {\"micro\": 1, \"minor\": 11, \"major\": 2}, \"package\": \" (v2.11.1-dirty)\"}, \"capabilities\": []}}" arch=amd64 name=kata-runtime pid=39135 source=virtcontainers subsystem=qmp
Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.548407139Z" level=info msg="{\"execute\":\"qmp_capabilities\"}" arch=amd64 name=kata-runtime pid=39135 source=virtcontainers subsystem=qmp
Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.549298946Z" level=info msg="{\"return\": {}}" arch=amd64 name=kata-runtime pid=39135 source=virtcontainers subsystem=qmp
Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.549461747Z" level=info msg="{\"arguments\":{\"id\":\"virtio-drive-b3177caca69e3f640d7b08e1b\"},\"execute\":\"device_del\"}" arch=amd64 name=kata-runtime pid=39135 source=virtcontainers subsystem=qmp
Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.551762164Z" level=info msg="{\"timestamp\": {\"seconds\": 1524232182, \"microseconds\": 551667}, \"event\": \"DEVICE_DELETED\", \"data\": {\"device\": \"virtio-drive-b3177caca69e3f640d7b08e1b\", \"path\": \"/machine/peripheral/virtio-drive-b3177caca69e3f640d7b08e1b\"}}" arch=amd64 name=kata-runtime pid=39135 source=virtcontainers subsystem=qmp
Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.551973665Z" level=info msg="{\"return\": {}}" arch=amd64 name=kata-runtime pid=39135 source=virtcontainers subsystem=qmp
Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.552169367Z" level=info msg="{\"arguments\":{\"node-name\":\"drive-b3177caca69e3f640d7b08e1b\"},\"execute\":\"blockdev-del\"}" arch=amd64 name=kata-runtime pid=39135 source=virtcontainers subsystem=qmp
Apr 20 13:49:42 openshift-fix kata-runtime[39135]: time="2018-04-20T13:49:42.554691085Z" level=info msg="{\"return\": {}}" arch=amd64 name=kata-runtime pid=39135 source=virtcontainers subsystem=qmp
Apr 20 13:49:42 openshift-fix kata-runtime[39152]: time="2018-04-20T13:49:42.57741825Z" level=debug msg="loaded configuration" command=state format=TOML name=kata-runtime pid=39152 source=runtime
Apr 20 13:49:42 openshift-fix kata-runtime[39152]: time="2018-04-20T13:49:42.577783952Z" level=info arguments="\"state b3177caca69e3f640d7b08e1b622fce1486429a5cddfd46b3d6bedfb2a304365\"" command=state commit=3dd37470b0f03ed8fd65bb79a5b684a7e47e5369 name=kata-runtime pid=39152 source=runtime version=0.0.1
Apr 20 13:49:42 openshift-fix kata-runtime[39152]: time="2018-04-20T13:49:42.581947983Z" level=info msg="Virtual endpoint unmarshalled [{{eb091a44-b5c0-4c6b-a693-4c48b54412fa br0 {eth0 02:00:ca:fe:00:00 [10.244.0.2/24 eth0]} {tap0 0a:58:0a:f4:00:02 []} 2 [0xc4201b8158 0xc4201b8168 0xc4201b8170 0xc4201b8178 0xc4201b8180 0xc4201b8188 0xc4201b8190 0xc4201b8198] [0xc4201b81a0 0xc4201b81a8 0xc4201b81b0 0xc4201b81b8 0xc4201b81c0 0xc4201b81c8 0xc4201b81d0 0xc4201b81d8]} {{{3 1450 0 eth0 0a:58:0a:f4:00:02 up|broadcast|multicast 69699 67 0 <nil>  0xc42024e240 0 0xc42019fdc0 ether <nil> up 0 0 0} veth} [10.244.0.2/24 eth0 fe80::d8f7:50ff:fe41:f5b3/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.2 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39152 source=virtcontainers
Apr 20 13:49:42 openshift-fix kata-runtime[39152]: time="2018-04-20T13:49:42.58572591Z" level=info msg="Virtual endpoint unmarshalled [{{a3646dcb-f0b6-4192-8ec5-032003d81994 br0 {eth0 02:00:ca:fe:00:00 [10.244.0.3/24 eth0]} {tap0 0a:58:0a:f4:00:03 []} 2 [0xc4201b8308 0xc4201b8310 0xc4201b8318 0xc4201b8320 0xc4201b8328 0xc4201b8330 0xc4201b8338 0xc4201b8340] [0xc4201b8348 0xc4201b8350 0xc4201b8358 0xc4201b8360 0xc4201b8368 0xc4201b8370 0xc4201b8378 0xc4201b8380]} {{{3 1450 0 eth0 0a:58:0a:f4:00:03 up|broadcast|multicast 69699 68 0 <nil>  0xc42024e600 0 0xc4202888c0 ether <nil> up 0 0 0} veth} [10.244.0.3/24 eth0 fe80::b408:87ff:fe33:9723/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.3 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39152 source=virtcontainers
Apr 20 13:49:42 openshift-fix kata-runtime[39159]: time="2018-04-20T13:49:42.595099778Z" level=debug msg="loaded configuration" command=state format=TOML name=kata-runtime pid=39159 source=runtime
Apr 20 13:49:42 openshift-fix kata-runtime[39159]: time="2018-04-20T13:49:42.595437281Z" level=info arguments="\"state b3177caca69e3f640d7b08e1b622fce1486429a5cddfd46b3d6bedfb2a304365\"" command=state commit=3dd37470b0f03ed8fd65bb79a5b684a7e47e5369 name=kata-runtime pid=39159 source=runtime version=0.0.1
Apr 20 13:49:42 openshift-fix kata-runtime[39159]: time="2018-04-20T13:49:42.598956606Z" level=info msg="Virtual endpoint unmarshalled [{{eb091a44-b5c0-4c6b-a693-4c48b54412fa br0 {eth0 02:00:ca:fe:00:00 [10.244.0.2/24 eth0]} {tap0 0a:58:0a:f4:00:02 []} 2 [0xc42000e1b8 0xc42000e1c8 0xc42000e1d0 0xc42000e1d8 0xc42000e1e0 0xc42000e1e8 0xc42000e1f0 0xc42000e1f8] [0xc42000e200 0xc42000e208 0xc42000e210 0xc42000e218 0xc42000e220 0xc42000e228 0xc42000e230 0xc42000e238]} {{{3 1450 0 eth0 0a:58:0a:f4:00:02 up|broadcast|multicast 69699 67 0 <nil>  0xc420174300 0 0xc420218380 ether <nil> up 0 0 0} veth} [10.244.0.2/24 eth0 fe80::d8f7:50ff:fe41:f5b3/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.2 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39159 source=virtcontainers
Apr 20 13:49:42 openshift-fix kata-runtime[39159]: time="2018-04-20T13:49:42.602497832Z" level=info msg="Virtual endpoint unmarshalled [{{a3646dcb-f0b6-4192-8ec5-032003d81994 br0 {eth0 02:00:ca:fe:00:00 [10.244.0.3/24 eth0]} {tap0 0a:58:0a:f4:00:03 []} 2 [0xc42000e368 0xc42000e370 0xc42000e378 0xc42000e380 0xc42000e388 0xc42000e390 0xc42000e398 0xc42000e3a0] [0xc42000e3a8 0xc42000e3b0 0xc42000e3b8 0xc42000e3c0 0xc42000e3c8 0xc42000e3d0 0xc42000e3d8 0xc42000e3e0]} {{{3 1450 0 eth0 0a:58:0a:f4:00:03 up|broadcast|multicast 69699 68 0 <nil>  0xc4201746c0 0 0xc420218e80 ether <nil> up 0 0 0} veth} [10.244.0.3/24 eth0 fe80::b408:87ff:fe33:9723/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.3 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39159 source=virtcontainers
Apr 20 13:49:42 openshift-fix kata-runtime[39170]: time="2018-04-20T13:49:42.701603251Z" level=debug msg="loaded configuration" command=state format=TOML name=kata-runtime pid=39170 source=runtime
Apr 20 13:49:42 openshift-fix kata-runtime[39170]: time="2018-04-20T13:49:42.701974954Z" level=info arguments="\"state b3177caca69e3f640d7b08e1b622fce1486429a5cddfd46b3d6bedfb2a304365\"" command=state commit=3dd37470b0f03ed8fd65bb79a5b684a7e47e5369 name=kata-runtime pid=39170 source=runtime version=0.0.1
Apr 20 13:49:42 openshift-fix kata-runtime[39170]: time="2018-04-20T13:49:42.705499079Z" level=info msg="Virtual endpoint unmarshalled [{{eb091a44-b5c0-4c6b-a693-4c48b54412fa br0 {eth0 02:00:ca:fe:00:00 [10.244.0.2/24 eth0]} {tap0 0a:58:0a:f4:00:02 []} 2 [0xc4201ba158 0xc4201ba168 0xc4201ba170 0xc4201ba178 0xc4201ba180 0xc4201ba188 0xc4201ba190 0xc4201ba198] [0xc4201ba1a0 0xc4201ba1a8 0xc4201ba1b0 0xc4201ba1b8 0xc4201ba1c0 0xc4201ba1c8 0xc4201ba1d0 0xc4201ba1d8]} {{{3 1450 0 eth0 0a:58:0a:f4:00:02 up|broadcast|multicast 69699 67 0 <nil>  0xc420250240 0 0xc42019fdc0 ether <nil> up 0 0 0} veth} [10.244.0.2/24 eth0 fe80::d8f7:50ff:fe41:f5b3/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.2 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39170 source=virtcontainers
Apr 20 13:49:42 openshift-fix kata-runtime[39170]: time="2018-04-20T13:49:42.708512501Z" level=info msg="Virtual endpoint unmarshalled [{{a3646dcb-f0b6-4192-8ec5-032003d81994 br0 {eth0 02:00:ca:fe:00:00 [10.244.0.3/24 eth0]} {tap0 0a:58:0a:f4:00:03 []} 2 [0xc4201ba308 0xc4201ba310 0xc4201ba318 0xc4201ba320 0xc4201ba328 0xc4201ba330 0xc4201ba338 0xc4201ba340] [0xc4201ba348 0xc4201ba350 0xc4201ba358 0xc4201ba360 0xc4201ba368 0xc4201ba370 0xc4201ba378 0xc4201ba380]} {{{3 1450 0 eth0 0a:58:0a:f4:00:03 up|broadcast|multicast 69699 68 0 <nil>  0xc420250600 0 0xc42028a8c0 ether <nil> up 0 0 0} veth} [10.244.0.3/24 eth0 fe80::b408:87ff:fe33:9723/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.3 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39170 source=virtcontainers
Apr 20 13:49:42 openshift-fix kata-runtime[39177]: time="2018-04-20T13:49:42.726384431Z" level=debug msg="loaded configuration" command=state format=TOML name=kata-runtime pid=39177 source=runtime
Apr 20 13:49:42 openshift-fix kata-runtime[39177]: time="2018-04-20T13:49:42.726649833Z" level=info arguments="\"state b3177caca69e3f640d7b08e1b622fce1486429a5cddfd46b3d6bedfb2a304365\"" command=state commit=3dd37470b0f03ed8fd65bb79a5b684a7e47e5369 name=kata-runtime pid=39177 source=runtime version=0.0.1
Apr 20 13:49:42 openshift-fix kata-runtime[39177]: time="2018-04-20T13:49:42.730301159Z" level=info msg="Virtual endpoint unmarshalled [{{eb091a44-b5c0-4c6b-a693-4c48b54412fa br0 {eth0 02:00:ca:fe:00:00 [10.244.0.2/24 eth0]} {tap0 0a:58:0a:f4:00:02 []} 2 [0xc42000e1b8 0xc42000e1c8 0xc42000e1d0 0xc42000e1d8 0xc42000e1e0 0xc42000e1e8 0xc42000e1f0 0xc42000e1f8] [0xc42000e200 0xc42000e208 0xc42000e210 0xc42000e218 0xc42000e220 0xc42000e228 0xc42000e230 0xc42000e238]} {{{3 1450 0 eth0 0a:58:0a:f4:00:02 up|broadcast|multicast 69699 67 0 <nil>  0xc42017c300 0 0xc420216380 ether <nil> up 0 0 0} veth} [10.244.0.2/24 eth0 fe80::d8f7:50ff:fe41:f5b3/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.2 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39177 source=virtcontainers
Apr 20 13:49:42 openshift-fix kata-runtime[39177]: time="2018-04-20T13:49:42.73316618Z" level=info msg="Virtual endpoint unmarshalled [{{a3646dcb-f0b6-4192-8ec5-032003d81994 br0 {eth0 02:00:ca:fe:00:00 [10.244.0.3/24 eth0]} {tap0 0a:58:0a:f4:00:03 []} 2 [0xc42000e368 0xc42000e370 0xc42000e378 0xc42000e380 0xc42000e388 0xc42000e390 0xc42000e398 0xc42000e3a0] [0xc42000e3a8 0xc42000e3b0 0xc42000e3b8 0xc42000e3c0 0xc42000e3c8 0xc42000e3d0 0xc42000e3d8 0xc42000e3e0]} {{{3 1450 0 eth0 0a:58:0a:f4:00:03 up|broadcast|multicast 69699 68 0 <nil>  0xc42017c6c0 0 0xc420216e80 ether <nil> up 0 0 0} veth} [10.244.0.3/24 eth0 fe80::b408:87ff:fe33:9723/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.3 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39177 source=virtcontainers
Apr 20 13:49:42 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:42.807110717Z" level=debug msg="loaded configuration" command=kill format=TOML name=kata-runtime pid=39205 source=runtime
Apr 20 13:49:42 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:42.807448419Z" level=info arguments="\"kill c5777808b4fbb86bd9a0aed4bea6ccd7b00c6947a597ecf829c3996257e90ce3 TERM\"" command=kill commit=3dd37470b0f03ed8fd65bb79a5b684a7e47e5369 name=kata-runtime pid=39205 source=runtime version=0.0.1
Apr 20 13:49:42 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:42.810975945Z" level=info msg="Virtual endpoint unmarshalled [{{eb091a44-b5c0-4c6b-a693-4c48b54412fa br0 {eth0 02:00:ca:fe:00:00 [10.244.0.2/24 eth0]} {tap0 0a:58:0a:f4:00:02 []} 2 [0xc42000e1b8 0xc42000e1c8 0xc42000e1d0 0xc42000e1d8 0xc42000e1e0 0xc42000e1e8 0xc42000e1f0 0xc42000e1f8] [0xc42000e200 0xc42000e208 0xc42000e210 0xc42000e218 0xc42000e220 0xc42000e228 0xc42000e230 0xc42000e238]} {{{3 1450 0 eth0 0a:58:0a:f4:00:02 up|broadcast|multicast 69699 67 0 <nil>  0xc420176300 0 0xc42020e380 ether <nil> up 0 0 0} veth} [10.244.0.2/24 eth0 fe80::d8f7:50ff:fe41:f5b3/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.2 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39205 source=virtcontainers
Apr 20 13:49:42 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:42.813965766Z" level=info msg="Virtual endpoint unmarshalled [{{a3646dcb-f0b6-4192-8ec5-032003d81994 br0 {eth0 02:00:ca:fe:00:00 [10.244.0.3/24 eth0]} {tap0 0a:58:0a:f4:00:03 []} 2 [0xc42000e368 0xc42000e370 0xc42000e378 0xc42000e380 0xc42000e388 0xc42000e390 0xc42000e398 0xc42000e3a0] [0xc42000e3a8 0xc42000e3b0 0xc42000e3b8 0xc42000e3c0 0xc42000e3c8 0xc42000e3d0 0xc42000e3d8 0xc42000e3e0]} {{{3 1450 0 eth0 0a:58:0a:f4:00:03 up|broadcast|multicast 69699 68 0 <nil>  0xc4201766c0 0 0xc42020ee80 ether <nil> up 0 0 0} veth} [10.244.0.3/24 eth0 fe80::b408:87ff:fe33:9723/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.3 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39205 source=virtcontainers
Apr 20 13:49:43 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:43.019021754Z" level=info msg="unplugging block device" arch=amd64 container-id=c5777808b4fbb86bd9a0aed4bea6ccd7b00c6947a597ecf829c3996257e90ce3 name=kata-runtime pid=39205 sandbox-id=c5777808b4fbb86bd9a0aed4bea6ccd7b00c6947a597ecf829c3996257e90ce3 source=virtcontainers subsystem=container
Apr 20 13:49:43 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:43.019558858Z" level=info msg="Unplugging block device" arch=amd64 container-id=c5777808b4fbb86bd9a0aed4bea6ccd7b00c6947a597ecf829c3996257e90ce3 device-id=drive-c5777808b4fbb86bd9a0aed4b name=kata-runtime pid=39205 sandbox-id=c5777808b4fbb86bd9a0aed4bea6ccd7b00c6947a597ecf829c3996257e90ce3 source=virtcontainers subsystem=container
Apr 20 13:49:43 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:43.020042562Z" level=info msg="{\"QMP\": {\"version\": {\"qemu\": {\"micro\": 1, \"minor\": 11, \"major\": 2}, \"package\": \" (v2.11.1-dirty)\"}, \"capabilities\": []}}" arch=amd64 name=kata-runtime pid=39205 source=virtcontainers subsystem=qmp
Apr 20 13:49:43 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:43.020557865Z" level=info msg="{\"execute\":\"qmp_capabilities\"}" arch=amd64 name=kata-runtime pid=39205 source=virtcontainers subsystem=qmp
Apr 20 13:49:43 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:43.021595873Z" level=info msg="{\"return\": {}}" arch=amd64 name=kata-runtime pid=39205 source=virtcontainers subsystem=qmp
Apr 20 13:49:43 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:43.022105577Z" level=info msg="{\"arguments\":{\"id\":\"virtio-drive-c5777808b4fbb86bd9a0aed4b\"},\"execute\":\"device_del\"}" arch=amd64 name=kata-runtime pid=39205 source=virtcontainers subsystem=qmp
Apr 20 13:49:43 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:43.024642295Z" level=info msg="{\"timestamp\": {\"seconds\": 1524232183, \"microseconds\": 24525}, \"event\": \"DEVICE_DELETED\", \"data\": {\"device\": \"virtio-drive-c5777808b4fbb86bd9a0aed4b\", \"path\": \"/machine/peripheral/virtio-drive-c5777808b4fbb86bd9a0aed4b\"}}" arch=amd64 name=kata-runtime pid=39205 source=virtcontainers subsystem=qmp
Apr 20 13:49:43 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:43.024739296Z" level=info msg="{\"return\": {}}" arch=amd64 name=kata-runtime pid=39205 source=virtcontainers subsystem=qmp
Apr 20 13:49:43 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:43.024939097Z" level=info msg="{\"arguments\":{\"node-name\":\"drive-c5777808b4fbb86bd9a0aed4b\"},\"execute\":\"blockdev-del\"}" arch=amd64 name=kata-runtime pid=39205 source=virtcontainers subsystem=qmp
Apr 20 13:49:43 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:43.028973226Z" level=info msg="{\"return\": {}}" arch=amd64 name=kata-runtime pid=39205 source=virtcontainers subsystem=qmp
Apr 20 13:49:43 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:43.02949713Z" level=info msg="Container already stopped" arch=amd64 container-id=b3177caca69e3f640d7b08e1b622fce1486429a5cddfd46b3d6bedfb2a304365 name=kata-runtime pid=39205 sandbox-id=c5777808b4fbb86bd9a0aed4bea6ccd7b00c6947a597ecf829c3996257e90ce3 source=virtcontainers subsystem=container
Apr 20 13:49:43 openshift-fix kata-runtime[39205]: time="2018-04-20T13:49:43.046385153Z" level=error msg="rpc error: code = Internal desc = Could not remove network route dest:\"10.244.0.0/16\" gateway:\"10.244.0.1\" device:\"eth0\" : rpc error: code = Internal desc = Could not remove route dest(10.244.0.0/16)/gw(10.244.0.1)/dev(eth0): no such process" command=kill name=kata-runtime pid=39205 source=runtime
Apr 20 13:49:43 openshift-fix kata-runtime[39217]: time="2018-04-20T13:49:43.059678549Z" level=debug msg="loaded configuration" command=state format=TOML name=kata-runtime pid=39217 source=runtime
Apr 20 13:49:43 openshift-fix kata-runtime[39217]: time="2018-04-20T13:49:43.060313654Z" level=info arguments="\"state c5777808b4fbb86bd9a0aed4bea6ccd7b00c6947a597ecf829c3996257e90ce3\"" command=state commit=3dd37470b0f03ed8fd65bb79a5b684a7e47e5369 name=kata-runtime pid=39217 source=runtime version=0.0.1
Apr 20 13:49:43 openshift-fix kata-runtime[39217]: time="2018-04-20T13:49:43.064180382Z" level=info msg="Virtual endpoint unmarshalled [{{eb091a44-b5c0-4c6b-a693-4c48b54412fa br0 {eth0 02:00:ca:fe:00:00 [10.244.0.2/24 eth0]} {tap0 0a:58:0a:f4:00:02 []} 2 [0xc4200761b0 0xc4200761c0 0xc4200761c8 0xc4200761d0 0xc4200761d8 0xc4200761e0 0xc4200761e8 0xc4200761f0] [0xc4200761f8 0xc420076200 0xc420076208 0xc420076210 0xc420076218 0xc420076220 0xc420076228 0xc420076230]} {{{3 1450 0 eth0 0a:58:0a:f4:00:02 up|broadcast|multicast 69699 67 0 <nil>  0xc420194300 0 0xc420256380 ether <nil> up 0 0 0} veth} [10.244.0.2/24 eth0 fe80::d8f7:50ff:fe41:f5b3/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.2 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39217 source=virtcontainers
Apr 20 13:49:43 openshift-fix kata-runtime[39217]: time="2018-04-20T13:49:43.07073443Z" level=info msg="Virtual endpoint unmarshalled [{{a3646dcb-f0b6-4192-8ec5-032003d81994 br0 {eth0 02:00:ca:fe:00:00 [10.244.0.3/24 eth0]} {tap0 0a:58:0a:f4:00:03 []} 2 [0xc420076360 0xc420076368 0xc420076370 0xc420076378 0xc420076380 0xc420076388 0xc420076390 0xc420076398] [0xc4200763a0 0xc4200763a8 0xc4200763b0 0xc4200763b8 0xc4200763c0 0xc4200763c8 0xc4200763d0 0xc4200763d8]} {{{3 1450 0 eth0 0a:58:0a:f4:00:03 up|broadcast|multicast 69699 68 0 <nil>  0xc4201946c0 0 0xc420256e80 ether <nil> up 0 0 0} veth} [10.244.0.3/24 eth0 fe80::b408:87ff:fe33:9723/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.3 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39217 source=virtcontainers
Apr 20 13:49:43 openshift-fix kata-runtime[39227]: time="2018-04-20T13:49:43.084908032Z" level=debug msg="loaded configuration" command=state format=TOML name=kata-runtime pid=39227 source=runtime
Apr 20 13:49:43 openshift-fix kata-runtime[39227]: time="2018-04-20T13:49:43.085775539Z" level=info arguments="\"state c5777808b4fbb86bd9a0aed4bea6ccd7b00c6947a597ecf829c3996257e90ce3\"" command=state commit=3dd37470b0f03ed8fd65bb79a5b684a7e47e5369 name=kata-runtime pid=39227 source=runtime version=0.0.1
Apr 20 13:49:43 openshift-fix kata-runtime[39227]: time="2018-04-20T13:49:43.091386379Z" level=info msg="Virtual endpoint unmarshalled [{{eb091a44-b5c0-4c6b-a693-4c48b54412fa br0 {eth0 02:00:ca:fe:00:00 [10.244.0.2/24 eth0]} {tap0 0a:58:0a:f4:00:02 []} 2 [0xc42000e168 0xc42000e178 0xc42000e180 0xc42000e188 0xc42000e190 0xc42000e198 0xc42000e1a0 0xc42000e1a8] [0xc42000e1b0 0xc42000e1b8 0xc42000e1c0 0xc42000e1c8 0xc42000e1d0 0xc42000e1d8 0xc42000e1e0 0xc42000e1e8]} {{{3 1450 0 eth0 0a:58:0a:f4:00:02 up|broadcast|multicast 69699 67 0 <nil>  0xc420248240 0 0xc4201a3dc0 ether <nil> up 0 0 0} veth} [10.244.0.2/24 eth0 fe80::d8f7:50ff:fe41:f5b3/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.2 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39227 source=virtcontainers
Apr 20 13:49:43 openshift-fix kata-runtime[39227]: time="2018-04-20T13:49:43.094494202Z" level=info msg="Virtual endpoint unmarshalled [{{a3646dcb-f0b6-4192-8ec5-032003d81994 br0 {eth0 02:00:ca:fe:00:00 [10.244.0.3/24 eth0]} {tap0 0a:58:0a:f4:00:03 []} 2 [0xc42000e318 0xc42000e320 0xc42000e328 0xc42000e330 0xc42000e338 0xc42000e340 0xc42000e348 0xc42000e350] [0xc42000e358 0xc42000e360 0xc42000e368 0xc42000e370 0xc42000e378 0xc42000e380 0xc42000e388 0xc42000e390]} {{{3 1450 0 eth0 0a:58:0a:f4:00:03 up|broadcast|multicast 69699 68 0 <nil>  0xc420248600 0 0xc4202808c0 ether <nil> up 0 0 0} veth} [10.244.0.3/24 eth0 fe80::b408:87ff:fe33:9723/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.3 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39227 source=virtcontainers
Apr 20 13:49:43 openshift-fix kata-runtime[39239]: time="2018-04-20T13:49:43.224805748Z" level=debug msg="loaded configuration" command=delete format=TOML name=kata-runtime pid=39239 source=runtime
Apr 20 13:49:43 openshift-fix kata-runtime[39239]: time="2018-04-20T13:49:43.225250951Z" level=info arguments="\"delete --force b3177caca69e3f640d7b08e1b622fce1486429a5cddfd46b3d6bedfb2a304365\"" command=deletecommit=3dd37470b0f03ed8fd65bb79a5b684a7e47e5369 name=kata-runtime pid=39239 source=runtime version=0.0.1
Apr 20 13:49:43 openshift-fix kata-runtime[39239]: time="2018-04-20T13:49:43.229024478Z" level=info msg="Virtual endpoint unmarshalled [{{eb091a44-b5c0-4c6b-a693-4c48b54412fa br0 {eth0 02:00:ca:fe:00:00 [10.244.0.2/24 eth0]} {tap0 0a:58:0a:f4:00:02 []} 2 [0xc42007a1b0 0xc42007a1c0 0xc42007a1c8 0xc42007a1d0 0xc42007a1d8 0xc42007a1e0 0xc42007a1e8 0xc42007a1f0] [0xc42007a1f8 0xc42007a200 0xc42007a208 0xc42007a210 0xc42007a218 0xc42007a220 0xc42007a228 0xc42007a230]} {{{3 1450 0 eth0 0a:58:0a:f4:00:02 up|broadcast|multicast 69699 67 0 <nil>  0xc420190300 0 0xc420230380 ether <nil> up 0 0 0} veth} [10.244.0.2/24 eth0 fe80::d8f7:50ff:fe41:f5b3/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.2 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39239 source=virtcontainers
Apr 20 13:49:43 openshift-fix kata-runtime[39239]: time="2018-04-20T13:49:43.232375902Z" level=info msg="Virtual endpoint unmarshalled [{{a3646dcb-f0b6-4192-8ec5-032003d81994 br0 {eth0 02:00:ca:fe:00:00 [10.244.0.3/24 eth0]} {tap0 0a:58:0a:f4:00:03 []} 2 [0xc42007a360 0xc42007a368 0xc42007a370 0xc42007a378 0xc42007a380 0xc42007a388 0xc42007a390 0xc42007a398] [0xc42007a3a0 0xc42007a3a8 0xc42007a3b0 0xc42007a3b8 0xc42007a3c0 0xc42007a3c8 0xc42007a3d0 0xc42007a3d8]} {{{3 1450 0 eth0 0a:58:0a:f4:00:03 up|broadcast|multicast 69699 68 0 <nil>  0xc4201906c0 0 0xc420230e80 ether <nil> up 0 0 0} veth} [10.244.0.3/24 eth0 fe80::b408:87ff:fe33:9723/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.3 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39239 source=virtcontainers
Apr 20 13:49:43 openshift-fix kata-runtime[39239]: time="2018-04-20T13:49:43.235127722Z" level=info msg="path mounted" command=delete name=kata-runtime path=/sys/fs/cgroup/cpu pid=39239 source=runtime type=cgroup
Apr 20 13:49:43 openshift-fix kata-runtime[39239]: time="2018-04-20T13:49:43.235189523Z" level=info msg="path mounted" command=delete name=kata-runtime path=/sys/fs/cgroup/pids pid=39239 source=runtime type=cgroup
Apr 20 13:50:26 openshift-fix kata-runtime[39397]: time="2018-04-20T13:50:26.249670013Z" level=debug msg="loaded configuration" command=delete format=TOML name=kata-runtime pid=39397 source=runtime
Apr 20 13:50:26 openshift-fix kata-runtime[39397]: time="2018-04-20T13:50:26.249950015Z" level=info arguments="\"delete --force c5777808b4fbb86bd9a0aed4bea6ccd7b00c6947a597ecf829c3996257e90ce3\"" command=deletecommit=3dd37470b0f03ed8fd65bb79a5b684a7e47e5369 name=kata-runtime pid=39397 source=runtime version=0.0.1
Apr 20 13:50:26 openshift-fix kata-runtime[39397]: time="2018-04-20T13:50:26.253789943Z" level=info msg="Virtual endpoint unmarshalled [{{eb091a44-b5c0-4c6b-a693-4c48b54412fa br0 {eth0 02:00:ca:fe:00:00 [10.244.0.2/24 eth0]} {tap0 0a:58:0a:f4:00:02 []} 2 [0xc42000e1c0 0xc42000e1d0 0xc42000e1d8 0xc42000e1e0 0xc42000e1e8 0xc42000e1f0 0xc42000e1f8 0xc42000e200] [0xc42000e208 0xc42000e210 0xc42000e218 0xc42000e220 0xc42000e228 0xc42000e230 0xc42000e238 0xc42000e240]} {{{3 1450 0 eth0 0a:58:0a:f4:00:02 up|broadcast|multicast 69699 67 0 <nil>  0xc420170300 0 0xc420216380 ether <nil> up 0 0 0} veth} [10.244.0.2/24 eth0 fe80::d8f7:50ff:fe41:f5b3/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.2 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39397 source=virtcontainers
Apr 20 13:50:26 openshift-fix kata-runtime[39397]: time="2018-04-20T13:50:26.256278861Z" level=info msg="Virtual endpoint unmarshalled [{{a3646dcb-f0b6-4192-8ec5-032003d81994 br0 {eth0 02:00:ca:fe:00:00 [10.244.0.3/24 eth0]} {tap0 0a:58:0a:f4:00:03 []} 2 [0xc42000e370 0xc42000e378 0xc42000e380 0xc42000e388 0xc42000e390 0xc42000e398 0xc42000e3a0 0xc42000e3a8] [0xc42000e3b0 0xc42000e3b8 0xc42000e3c0 0xc42000e3c8 0xc42000e3d0 0xc42000e3d8 0xc42000e3e0 0xc42000e3e8]} {{{3 1450 0 eth0 0a:58:0a:f4:00:03 up|broadcast|multicast 69699 68 0 <nil>  0xc420170600 0 0xc420216c40 ether <nil> up 0 0 0} veth} [10.244.0.3/24 eth0 fe80::b408:87ff:fe33:9723/64] [{Ifindex: 3 Dst: <nil> Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/24 Src: 10.244.0.3 Gw: <nil> Flags: [] Table: 254} {Ifindex: 3 Dst: 10.244.0.0/16 Src: <nil> Gw: 10.244.0.1 Flags: [] Table: 254} {Ifindex: 3 Dst: fe80::/64 Src: <nil> Gw: <nil> Flags: [] Table: 254}] {[]  [] []}} false virtual}]" arch=amd64 name=kata-runtime pid=39397 source=virtcontainers
Apr 20 13:50:26 openshift-fix kata-runtime[39397]: time="2018-04-20T13:50:26.257210268Z" level=error msg="Sandbox not ready, paused or stopped, impossible to delete" command=delete name=kata-runtime pid=39397 source=runtime

Again after this, kata-runtime list does not work:

$ sudo -E kata-runtime list
stat /var/lib/containers/storage/devicemapper/mnt/b012c5a502633a607ed093e230226f4b9a7c1709f3998a071097865367586f8b/rootfs: no such file or directory

@sboeuf
Copy link
Author

sboeuf commented Apr 20, 2018

Thanks @chavafg , I'll have to investigate a bit more on this one!

@sboeuf
Copy link
Author

sboeuf commented Apr 20, 2018

/cc @egernst
You need to put return nil here to avoid getting the remove network issue.

@sboeuf
Copy link
Author

sboeuf commented Apr 20, 2018

@chavafg @egernst FWIW, I could properly run a kata-runtime list after I have started bats nginx.bats, and it returned:

ID                                                                 PID         STATUS      BUNDLE                                                                                                                      CREATED                          OWNER
b158e54c68f225d6fd8e741da1ce53fa2c54e8b1b8e5a7a4b891c6e2264b9296   92575       running     /run/containers/storage/devicemapper-containers/b158e54c68f225d6fd8e741da1ce53fa2c54e8b1b8e5a7a4b891c6e2264b9296/userdata   2018-04-20T22:23:35.483591908Z   #0
d03a2966c354988fd723d0cdf75c4d68e46e1c4e123e7d3d09b9c2f8aef91f80   92702       running     /run/containers/storage/devicemapper-containers/d03a2966c354988fd723d0cdf75c4d68e46e1c4e123e7d3d09b9c2f8aef91f80/userdata   2018-04-20T22:23:43.259297608Z   #0
65366cc1b16cf4e1c25b82642b60ecef47581579be701cd29f02de3b3edb9bd2   92966       running     /run/containers/storage/devicemapper-containers/65366cc1b16cf4e1c25b82642b60ecef47581579be701cd29f02de3b3edb9bd2/userdata   2018-04-20T22:23:53.276836704Z   #0
66c57c1d34714ffbd2e1b0aeb2ae3b18c4e81342f8aff0e54d4e0f1e3186c0d3   93113       running     /run/containers/storage/devicemapper-containers/66c57c1d34714ffbd2e1b0aeb2ae3b18c4e81342f8aff0e54d4e0f1e3186c0d3/userdata   2018-04-20T22:24:00.145826271Z   #0

But something went wrong with sudo -E kubeadm reset --cri-socket /var/run/crio/crio.sock:

[preflight] Running pre-flight checks.
[reset] Stopping the kubelet service.
[reset] Unmounting mounted directories in "/var/lib/kubelet"
[reset] Removing kubernetes-managed containers.
[reset] Cleaning up running containers using crictl with socket /var/run/crio/crio.sock
[reset] Failed to stop the running containers using crictl. Trying using docker instead.
[reset] Deleting contents of stateful directories: [/var/lib/kubelet /etc/cni/net.d /var/lib/dockershim /var/run/kubernetes /var/lib/etcd]
[reset] Deleting contents of config directories: [/etc/kubernetes/manifests /etc/kubernetes/pki]
[reset] Deleting files: [/etc/kubernetes/admin.conf /etc/kubernetes/kubelet.conf /etc/kubernetes/controller-manager.conf /etc/kubernetes/scheduler.conf]

Resulting in error when running kata-runtime list again:

stat /var/lib/containers/storage/devicemapper/mnt/89e81282013b156bbb84307630b07f7d36386d5c2205eafbacb052bd6cadb28b/rootfs: no such file or directory

@sboeuf sboeuf changed the title cli: Move the pod stop to OCI kill lifecycle cli: Don't wait for OCI delete to stop the sandbox Apr 23, 2018
@sboeuf
Copy link
Author

sboeuf commented Apr 23, 2018

Ready to be reviewed.
@bergwolf @jodh-intel @chavafg @egernst @grahamwhaley PTAL

cli/delete.go Outdated
// reason because that's the behavior of "--force". Also, a
// previous call to kill might have been performed earlier,
// causing this one to fail.
if err := vci.KillContainer(sandboxID, containerID, syscall.SIGKILL, true); err != nil {
Copy link
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

deleteContainer(forceStop==true) will also send SIGKILL to the container. Is there any reason that we need to do it here before virtcontainers does it?

Copy link
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

well, deleteSandbox() also sends it. I do not see why we need it here.

Copy link
Author

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Where are we killing the containers ?

Copy link
Author

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Oh nevermind, I forgot this was handled through virtcontainers...

Copy link
Author

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

I have addressed your comment.

@sboeuf sboeuf force-pushed the fix_openshift_k8s branch 3 times, most recently from 202cd2d to ff6c8c6 Compare April 24, 2018 07:15
@sboeuf
Copy link
Author

sboeuf commented Apr 24, 2018

@WeiZhang555 @laijs @bergwolf PTAL

}

switch containerType {
case vc.PodSandbox:
Copy link
Member

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

@sboeuf when do crio/cri-containerd/docker-shim etc. set the podsandbox annotation? It is set for the first container created in a sandbox?

Copy link
Author

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

It is set for the container representing the sandbox, and yes it is usually the first one. In case of CRIO, they create what they call an infra container as being the sandbox, and then they spawn a bunch of other containers later.

case vc.PodContainer:
_, err = vci.StopContainer(sandboxID, containerID)
default:
return fmt.Errorf("Invalid container type found")
Copy link
Contributor

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

Can you add containerID to this error?

@jodh-intel
Copy link
Contributor

I think the changes make, but I see them as two separate changesets, hence better as two separate commits.

Also, I am finding the description of the PR (what has this got to do with "wait"-ing?) and the commit description confusing.

@sboeuf
Copy link
Author

sboeuf commented Apr 25, 2018

@jodh-intel I can split them into 2 commits but this means the first one won't be working without the second, which should be fine since we only care about the status of the whole PR.
Now, about your comment regarding the PR description, I don't know what to add here, do you have any suggestion ?

Sebastien Boeuf added 2 commits April 25, 2018 09:01
The way a delete works, it was always trying to stop the sandbox, even
when the force flag was not enabled. Because we want to be able to stop
the sandbox from a kill command, this means a sandbox stop might be
called twice, and we don't want the second stop to fail, leading to the
failure of the delete command.

That's why this commit checks for the sandbox status before to try
stopping the sandbox.

Fixes kata-containers#246

Signed-off-by: Sebastien Boeuf <[email protected]>
The same way a caller of "kata-runtime kill 12345" expects
the container 12345 to be killed, the same call to a container
representing a sandbox should actually kill the sandbox, meaning
it would be stopped after the container has been killed.

This way, the caller knows the VM is stopped after kill returns.
This is an issue raised by Openshift and Kubernetes tests. They
call into delete way after the call to kill has been submitted,
and in the meantime they kill all processes related to the container,
meaning they do kill the VM before we could do it ourselves. In this
case, the delete responsible of stopping the VM comes too late and it
returns an error when trying to destroy the sandbox while trying to
communicate with the agent since the VM is not here anymore.

This commit addresses this issue by letting "kill" call into
StopSandbox() if the command relates to a sandbox instead of
a simple container.

Fixes kata-containers#246

Signed-off-by: Sebastien Boeuf <[email protected]>
@codecov
Copy link

codecov bot commented Apr 25, 2018

Codecov Report

Merging #232 into master will increase coverage by 0.1%.
The diff coverage is 73.33%.

Impacted file tree graph

@@            Coverage Diff            @@
##           master     #232     +/-   ##
=========================================
+ Coverage   65.15%   65.26%   +0.1%     
=========================================
  Files          74       74             
  Lines        7863     7876     +13     
=========================================
+ Hits         5123     5140     +17     
+ Misses       2186     2182      -4     
  Partials      554      554
Impacted Files Coverage Δ
cli/delete.go 96.82% <100%> (+0.21%) ⬆️
cli/kill.go 91.66% <60%> (-8.34%) ⬇️
virtcontainers/pkg/hyperstart/multicast.go 64.1% <0%> (+10.25%) ⬆️

Continue to review full report at Codecov.

Legend - Click here to learn more
Δ = absolute <relative> (impact), ø = not affected, ? = missing data
Powered by Codecov. Last update 45e3f85...07af4ed. Read the comment docs.

@sboeuf
Copy link
Author

sboeuf commented Apr 25, 2018

@jodh-intel I have just split into 2 different commits, providing a separate description for kill.go and delete.go changes.

Copy link
Member

@amshinde amshinde left a comment

Choose a reason for hiding this comment

The reason will be displayed to describe this comment to others. Learn more.

lgtm

@jodh-intel
Copy link
Contributor

jodh-intel commented Apr 26, 2018

Thanks @sboeuf! I appreciate that that's a lot of text to describe a relatively small code change, but I do think it makes the behaviour and rationale for the change much clearer.

lgtm

Approved with PullApprove

@jodh-intel
Copy link
Contributor

@sboeuf - I'll let you remove the dnm label when you're ready.

@egernst egernst merged commit ff3518e into kata-containers:master Apr 26, 2018
@egernst egernst removed the review label Apr 26, 2018
mcastelino pushed a commit to mcastelino/tests that referenced this pull request Jan 23, 2019
This change adds openshift installation into the CI process
and executes a simple test that verifies connectivity between
an openshift pod and the host.

Fixes: clearcontainers#220.

Depends-on: github.com/kata-containers/runtime#232

Signed-off-by: Salvador Fuentes <[email protected]>
zklei pushed a commit to zklei/runtime that referenced this pull request Jun 13, 2019
Once all vCPUs have been connected, cpuset cgroup MUST BE updated,
to achieve that, each cpuset cgroup parent of the container
MUST BE updated with the actual range of vCPUs.

fixes kata-containers#239
fixes kata-containers#232

Signed-off-by: Julio Montes <[email protected]>
Sign up for free to subscribe to this conversation on GitHub. Already have an account? Sign in.
Labels
None yet
Projects
None yet
Development

Successfully merging this pull request may close these issues.

7 participants