Console Output

Skipping 88 KB.. Full Log
TASK [stat the expected cri-o directory] ***************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:3
ok: [localhost] => {"changed": false, "stat": {"atime": 1613524594.481922, "attr_flags": "e", "attributes": ["extents"], "block_size": 4096, "blocks": 8, "charset": "binary", "ctime": 1638567472.1257799, "dev": 51713, "device_type": 0, "executable": true, "exists": true, "gid": 1002, "gr_name": "origin", "inode": 3407877, "isblk": false, "ischr": false, "isdir": true, "isfifo": false, "isgid": false, "islnk": false, "isreg": false, "issock": false, "isuid": false, "mimetype": "inode/directory", "mode": "0775", "mtime": 1638567472.1257799, "nlink": 23, "path": "/go/src/github.com/cri-o/cri-o", "pw_name": "origin", "readable": true, "rgrp": true, "roth": true, "rusr": true, "size": 4096, "uid": 1002, "version": "2317783695", "wgrp": true, "woth": false, "writeable": true, "wusr": true, "xgrp": true, "xoth": true, "xusr": true}}

TASK [expect cri-o to be cloned already] ***************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:8
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [build cri-o] *************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:13
redirecting (type: modules) ansible.builtin.make to community.general.make
changed: [localhost] => {"changed": true, "chdir": "/go/src/github.com/cri-o/cri-o", "file": null, "params": null, "stderr": "time=\"2021-12-03T21:41:12Z\" level=warning msg=\"Failed to decode the keys [\\\"storage.options.override_kernel_check\\\" \\\"storage.options.thinpool.ostree_repo\\\" \\\"storage.options.thinpool.skip_mount_home\\\"] from \\\"/etc/containers/storage.conf\\\".\"\ntime=\"2021-12-03 21:41:12.628389955Z\" level=info msg=\"Starting CRI-O, version: 1.23.0, git: fab9cf3b319ba054fc3b13c9723af70ec5a7bc2a(clean)\"\nlevel=info msg=\"Using default capabilities: CAP_CHOWN, CAP_DAC_OVERRIDE, CAP_FSETID, CAP_FOWNER, CAP_SETGID, CAP_SETUID, CAP_SETPCAP, CAP_NET_BIND_SERVICE, CAP_KILL\"", "stderr_lines": ["time=\"2021-12-03T21:41:12Z\" level=warning msg=\"Failed to decode the keys [\\\"storage.options.override_kernel_check\\\" \\\"storage.options.thinpool.ostree_repo\\\" \\\"storage.options.thinpool.skip_mount_home\\\"] from \\\"/etc/containers/storage.conf\\\".\"", "time=\"2021-12-03 21:41:12.628389955Z\" level=info msg=\"Starting CRI-O, version: 1.23.0, git: fab9cf3b319ba054fc3b13c9723af70ec5a7bc2a(clean)\"", "level=info msg=\"Using default capabilities: CAP_CHOWN, CAP_DAC_OVERRIDE, CAP_FSETID, CAP_FOWNER, CAP_SETGID, CAP_SETUID, CAP_SETPCAP, CAP_NET_BIND_SERVICE, CAP_KILL\""], "stdout": "touch \"/go/.gopathok\"\ngo build -trimpath  -ldflags '-s -w -X github.com/cri-o/cri-o/internal/pkg/criocli.DefaultsPath=\"\" -X github.com/cri-o/cri-o/internal/version.buildDate='2021-12-03T21:38:48Z' -X github.com/cri-o/cri-o/internal/version.gitCommit=fab9cf3b319ba054fc3b13c9723af70ec5a7bc2a -X github.com/cri-o/cri-o/internal/version.gitTreeState=clean ' -tags \"containers_image_ostree_stub  exclude_graphdriver_btrfs btrfs_noversion   containers_image_openpgp seccomp selinux \" -o bin/crio github.com/cri-o/cri-o/cmd/crio\ngo build -trimpath  -ldflags '-s -w -X github.com/cri-o/cri-o/internal/pkg/criocli.DefaultsPath=\"\" -X github.com/cri-o/cri-o/internal/version.buildDate='2021-12-03T21:41:07Z' -X github.com/cri-o/cri-o/internal/version.gitCommit=fab9cf3b319ba054fc3b13c9723af70ec5a7bc2a -X github.com/cri-o/cri-o/internal/version.gitTreeState=clean ' -tags \"containers_image_ostree_stub  exclude_graphdriver_btrfs btrfs_noversion   containers_image_openpgp seccomp selinux \" -o bin/crio-status github.com/cri-o/cri-o/cmd/crio-status\n/usr/bin/gmake -C pinns\ngmake[1]: Entering directory '/go/src/github.com/cri-o/cri-o/pinns'\ncc -std=c99 -Os -Wall -Werror -Wextra -static -O3 -o src/sysctl.o -c src/sysctl.c\ncc -std=c99 -Os -Wall -Werror -Wextra -static -O3 -o src/pinns.o -c src/pinns.c\ncc -o ../bin/pinns src/sysctl.o src/pinns.o -std=c99 -Os -Wall -Werror -Wextra -static \nstrip -s ../bin/pinns\ngmake[1]: Leaving directory '/go/src/github.com/cri-o/cri-o/pinns'\n./bin/crio -d \"\" --config=\"\"  config > crio.conf\n(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio-status.8.md -out docs/crio-status.8.tmp && touch docs/crio-status.8.tmp && mv docs/crio-status.8.tmp docs/crio-status.8) || \\\n\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio-status.8.md -out docs/crio-status.8.tmp && touch docs/crio-status.8.tmp && mv docs/crio-status.8.tmp docs/crio-status.8)\n(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.5.md -out docs/crio.conf.5.tmp && touch docs/crio.conf.5.tmp && mv docs/crio.conf.5.tmp docs/crio.conf.5) || \\\n\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.5.md -out docs/crio.conf.5.tmp && touch docs/crio.conf.5.tmp && mv docs/crio.conf.5.tmp docs/crio.conf.5)\n(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.d.5.md -out docs/crio.conf.d.5.tmp && touch docs/crio.conf.d.5.tmp && mv docs/crio.conf.d.5.tmp docs/crio.conf.d.5) || \\\n\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.d.5.md -out docs/crio.conf.d.5.tmp && touch docs/crio.conf.d.5.tmp && mv docs/crio.conf.d.5.tmp docs/crio.conf.d.5)\n(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.8.md -out docs/crio.8.tmp && touch docs/crio.8.tmp && mv docs/crio.8.tmp docs/crio.8) || \\\n\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.8.md -out docs/crio.8.tmp && touch docs/crio.8.tmp && mv docs/crio.8.tmp docs/crio.8)", "stdout_lines": ["touch \"/go/.gopathok\"", "go build -trimpath  -ldflags '-s -w -X github.com/cri-o/cri-o/internal/pkg/criocli.DefaultsPath=\"\" -X github.com/cri-o/cri-o/internal/version.buildDate='2021-12-03T21:38:48Z' -X github.com/cri-o/cri-o/internal/version.gitCommit=fab9cf3b319ba054fc3b13c9723af70ec5a7bc2a -X github.com/cri-o/cri-o/internal/version.gitTreeState=clean ' -tags \"containers_image_ostree_stub  exclude_graphdriver_btrfs btrfs_noversion   containers_image_openpgp seccomp selinux \" -o bin/crio github.com/cri-o/cri-o/cmd/crio", "go build -trimpath  -ldflags '-s -w -X github.com/cri-o/cri-o/internal/pkg/criocli.DefaultsPath=\"\" -X github.com/cri-o/cri-o/internal/version.buildDate='2021-12-03T21:41:07Z' -X github.com/cri-o/cri-o/internal/version.gitCommit=fab9cf3b319ba054fc3b13c9723af70ec5a7bc2a -X github.com/cri-o/cri-o/internal/version.gitTreeState=clean ' -tags \"containers_image_ostree_stub  exclude_graphdriver_btrfs btrfs_noversion   containers_image_openpgp seccomp selinux \" -o bin/crio-status github.com/cri-o/cri-o/cmd/crio-status", "/usr/bin/gmake -C pinns", "gmake[1]: Entering directory '/go/src/github.com/cri-o/cri-o/pinns'", "cc -std=c99 -Os -Wall -Werror -Wextra -static -O3 -o src/sysctl.o -c src/sysctl.c", "cc -std=c99 -Os -Wall -Werror -Wextra -static -O3 -o src/pinns.o -c src/pinns.c", "cc -o ../bin/pinns src/sysctl.o src/pinns.o -std=c99 -Os -Wall -Werror -Wextra -static ", "strip -s ../bin/pinns", "gmake[1]: Leaving directory '/go/src/github.com/cri-o/cri-o/pinns'", "./bin/crio -d \"\" --config=\"\"  config > crio.conf", "(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio-status.8.md -out docs/crio-status.8.tmp && touch docs/crio-status.8.tmp && mv docs/crio-status.8.tmp docs/crio-status.8) || \\", "\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio-status.8.md -out docs/crio-status.8.tmp && touch docs/crio-status.8.tmp && mv docs/crio-status.8.tmp docs/crio-status.8)", "(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.5.md -out docs/crio.conf.5.tmp && touch docs/crio.conf.5.tmp && mv docs/crio.conf.5.tmp docs/crio.conf.5) || \\", "\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.5.md -out docs/crio.conf.5.tmp && touch docs/crio.conf.5.tmp && mv docs/crio.conf.5.tmp docs/crio.conf.5)", "(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.d.5.md -out docs/crio.conf.d.5.tmp && touch docs/crio.conf.d.5.tmp && mv docs/crio.conf.d.5.tmp docs/crio.conf.d.5) || \\", "\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.conf.d.5.md -out docs/crio.conf.d.5.tmp && touch docs/crio.conf.d.5.tmp && mv docs/crio.conf.d.5.tmp docs/crio.conf.d.5)", "(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.8.md -out docs/crio.8.tmp && touch docs/crio.8.tmp && mv docs/crio.8.tmp docs/crio.8) || \\", "\t(/go/src/github.com/cri-o/cri-o/build/bin/go-md2man -in docs/crio.8.md -out docs/crio.8.tmp && touch docs/crio.8.tmp && mv docs/crio.8.tmp docs/crio.8)"], "target": null}

TASK [link pinns] **************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:17
changed: [localhost] => {"changed": true, "dest": "/bin/pinns", "gid": 0, "group": "root", "mode": "0777", "owner": "root", "secontext": "unconfined_u:object_r:bin_t:s0", "size": 40, "src": "/go/src/github.com/cri-o/cri-o/bin/pinns", "state": "link", "uid": 0}

TASK [set RestartPolicy in systemd unit appropriate for tests] *****************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:23
changed: [localhost] => {"backup": "", "changed": true, "msg": "line replaced"}

TASK [install cri-o] ***********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:29
redirecting (type: modules) ansible.builtin.make to community.general.make
changed: [localhost] => {"changed": true, "chdir": "/go/src/github.com/cri-o/cri-o", "file": null, "params": null, "stderr": "", "stderr_lines": [], "stdout": "/usr/bin/gmake -C pinns\ngmake[1]: Entering directory '/go/src/github.com/cri-o/cri-o/pinns'\ngmake[1]: Nothing to be done for 'all'.\ngmake[1]: Leaving directory '/go/src/github.com/cri-o/cri-o/pinns'\ninstall -Z -D -m 755 bin/crio /usr/local/bin/crio\ninstall -Z -D -m 755 bin/crio-status /usr/local/bin/crio-status\ninstall -Z -D -m 755 bin/pinns /usr/local/bin/pinns\ninstall -Z -d -m 755 /usr/local/share/man/man5\ninstall -Z -d -m 755 /usr/local/share/man/man8\ninstall -Z -m 644 docs/crio.conf.5 docs/crio.conf.d.5 -t /usr/local/share/man/man5\ninstall -Z -m 644 docs/crio-status.8 docs/crio.8 -t /usr/local/share/man/man8\ninstall -Z -d -m 755 /usr/local/share/bash-completion/completions\ninstall -Z -d -m 755 /usr/local/share/fish/completions\ninstall -Z -d -m 755 /usr/local/share/zsh/site-functions\ninstall -Z -D -m 644 -t /usr/local/share/bash-completion/completions completions/bash/crio\ninstall -Z -D -m 644 -t /usr/local/share/fish/completions completions/fish/crio.fish\ninstall -Z -D -m 644 -t /usr/local/share/zsh/site-functions  completions/zsh/_crio\ninstall -Z -D -m 644 -t /usr/local/share/bash-completion/completions completions/bash/crio-status\ninstall -Z -D -m 644 -t /usr/local/share/fish/completions completions/fish/crio-status.fish\ninstall -Z -D -m 644 -t /usr/local/share/zsh/site-functions  completions/zsh/_crio-status\ninstall -Z -D -m 644 contrib/systemd/crio.service /usr/local/lib/systemd/system/crio.service\ninstall -Z -D -m 644 contrib/systemd/crio-wipe.service /usr/local/lib/systemd/system/crio-wipe.service\ninstall -Z -d /usr/local/share/containers/oci/hooks.d\ninstall -Z -d /etc/crio/crio.conf.d\ninstall -Z -D -m 644 crio.conf /etc/crio/crio.conf\ninstall -Z -D -m 644 crio-umount.conf /usr/local/share/oci-umount/oci-umount.d/crio-umount.conf\ninstall -Z -D -m 644 crictl.yaml /etc", "stdout_lines": ["/usr/bin/gmake -C pinns", "gmake[1]: Entering directory '/go/src/github.com/cri-o/cri-o/pinns'", "gmake[1]: Nothing to be done for 'all'.", "gmake[1]: Leaving directory '/go/src/github.com/cri-o/cri-o/pinns'", "install -Z -D -m 755 bin/crio /usr/local/bin/crio", "install -Z -D -m 755 bin/crio-status /usr/local/bin/crio-status", "install -Z -D -m 755 bin/pinns /usr/local/bin/pinns", "install -Z -d -m 755 /usr/local/share/man/man5", "install -Z -d -m 755 /usr/local/share/man/man8", "install -Z -m 644 docs/crio.conf.5 docs/crio.conf.d.5 -t /usr/local/share/man/man5", "install -Z -m 644 docs/crio-status.8 docs/crio.8 -t /usr/local/share/man/man8", "install -Z -d -m 755 /usr/local/share/bash-completion/completions", "install -Z -d -m 755 /usr/local/share/fish/completions", "install -Z -d -m 755 /usr/local/share/zsh/site-functions", "install -Z -D -m 644 -t /usr/local/share/bash-completion/completions completions/bash/crio", "install -Z -D -m 644 -t /usr/local/share/fish/completions completions/fish/crio.fish", "install -Z -D -m 644 -t /usr/local/share/zsh/site-functions  completions/zsh/_crio", "install -Z -D -m 644 -t /usr/local/share/bash-completion/completions completions/bash/crio-status", "install -Z -D -m 644 -t /usr/local/share/fish/completions completions/fish/crio-status.fish", "install -Z -D -m 644 -t /usr/local/share/zsh/site-functions  completions/zsh/_crio-status", "install -Z -D -m 644 contrib/systemd/crio.service /usr/local/lib/systemd/system/crio.service", "install -Z -D -m 644 contrib/systemd/crio-wipe.service /usr/local/lib/systemd/system/crio-wipe.service", "install -Z -d /usr/local/share/containers/oci/hooks.d", "install -Z -d /etc/crio/crio.conf.d", "install -Z -D -m 644 crio.conf /etc/crio/crio.conf", "install -Z -D -m 644 crio-umount.conf /usr/local/share/oci-umount/oci-umount.d/crio-umount.conf", "install -Z -D -m 644 crictl.yaml /etc"], "target": "install"}

TASK [set manage network ns lifecycle and drop infra] **************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:34
changed: [localhost] => {"changed": true, "checksum": "30fac5adc641b03336f6c51c1e87021307a5730b", "dest": "/etc/crio/crio.conf.d/01-ns-lifecycle.conf", "gid": 0, "group": "root", "md5sum": "9c43a235ddbf3a00264bb3e7b63186e2", "mode": "0644", "owner": "root", "secontext": "system_u:object_r:container_config_t:s0", "size": 64, "src": "/home/origin/.ansible/tmp/ansible-tmp-1638567683.9208205-11281-4335531226792/source", "state": "file", "uid": 0}

TASK [use crun] ****************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:42
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [use kata] ****************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:51
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [install configs] *********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:63
changed: [localhost] => (item={'src': 'contrib/cni/10-crio-bridge.conf', 'dest': '/etc/cni/net.d/10-crio-bridge.conf'}) => {"ansible_loop_var": "item", "changed": true, "checksum": "f02fc9546988db3da8fd15ca847f1f687c45d28f", "dest": "/etc/cni/net.d/10-crio-bridge.conf", "gid": 0, "group": "root", "item": {"dest": "/etc/cni/net.d/10-crio-bridge.conf", "src": "contrib/cni/10-crio-bridge.conf"}, "md5sum": "166dad5c7f744b8ef89db0d257dedb3c", "mode": "0644", "owner": "root", "secontext": "system_u:object_r:etc_t:s0", "size": 438, "src": "/go/src/github.com/cri-o/cri-o/contrib/cni/10-crio-bridge.conf", "state": "file", "uid": 0}
changed: [localhost] => (item={'src': 'contrib/cni/99-loopback.conf', 'dest': '/etc/cni/net.d/99-loopback.conf'}) => {"ansible_loop_var": "item", "changed": true, "checksum": "c9669aa8c89717afc5ddbef5611b81e0f56401d3", "dest": "/etc/cni/net.d/99-loopback.conf", "gid": 0, "group": "root", "item": {"dest": "/etc/cni/net.d/99-loopback.conf", "src": "contrib/cni/99-loopback.conf"}, "md5sum": "395cf6671edceebafc3602c73d8647dd", "mode": "0644", "owner": "root", "secontext": "system_u:object_r:etc_t:s0", "size": 54, "src": "/go/src/github.com/cri-o/cri-o/contrib/cni/99-loopback.conf", "state": "file", "uid": 0}
changed: [localhost] => (item={'src': 'test/redhat_sigstore.yaml', 'dest': '/etc/containers/registries.d/registry.access.redhat.com.yaml'}) => {"ansible_loop_var": "item", "changed": true, "checksum": "7fb85b838ce225307dcc630fd6bbaf3b5b3c159a", "dest": "/etc/containers/registries.d/registry.access.redhat.com.yaml", "gid": 0, "group": "root", "item": {"dest": "/etc/containers/registries.d/registry.access.redhat.com.yaml", "src": "test/redhat_sigstore.yaml"}, "md5sum": "c458a83d3c9e915490cb78e7da481731", "mode": "0644", "owner": "root", "secontext": "system_u:object_r:etc_t:s0", "size": 112, "src": "/go/src/github.com/cri-o/cri-o/test/redhat_sigstore.yaml", "state": "file", "uid": 0}

TASK [run with overlay] ********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:76
changed: [localhost] => {"changed": true, "checksum": "8ba9b88fae016d5f0ac1fbe2dc4dd8788f255906", "dest": "/etc/crio/crio.conf.d/01-overlay.conf", "gid": 0, "group": "root", "md5sum": "941d62d3e35f856e260abe9dcb940516", "mode": "0644", "owner": "root", "secontext": "system_u:object_r:container_config_t:s0", "size": 34, "src": "/home/origin/.ansible/tmp/ansible-tmp-1638567685.138133-11366-180661730727179/source", "state": "file", "uid": 0}

TASK [add quay.io and docker.io as default registries] *************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:83
changed: [localhost] => {"changed": true, "checksum": "c5dae4dd339971de6933e35ae2bde2226a5f2f42", "dest": "/etc/crio/crio.conf.d/01-registries.conf", "gid": 0, "group": "root", "md5sum": "52494863d04fa64de6927b7cce03c937", "mode": "0644", "owner": "root", "secontext": "system_u:object_r:container_config_t:s0", "size": 53, "src": "/home/origin/.ansible/tmp/ansible-tmp-1638567685.4986424-11394-276152091773124/source", "state": "file", "uid": 0}

TASK [remove storage.conf to avoid configuration conflicts] ********************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-o.yml:90
changed: [localhost] => {"changed": true, "path": "/etc/containers/storage.conf", "state": "absent"}

TASK [clone conmon source repo] ************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/conmon.yml:3
changed: [localhost] => {"after": "c3f31c0671f6c84f5e02ec710385e1e8f2936066", "before": "13244db638cf987c415298a3c23393ae5abeb885", "changed": true, "remote_url_changed": false}

TASK [build conmon] ************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/conmon.yml:9
redirecting (type: modules) ansible.builtin.make to community.general.make
changed: [localhost] => {"changed": true, "chdir": "/go/src/github.com/containers/conmon", "file": null, "params": null, "stderr": "", "stderr_lines": [], "stdout": "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/conmon.o -c src/conmon.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/cmsg.o -c src/cmsg.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/ctr_logging.o -c src/ctr_logging.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/utils.o -c src/utils.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/cli.o -c src/cli.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/globals.o -c src/globals.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/cgroup.o -c src/cgroup.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/conn_sock.o -c src/conn_sock.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/oom.o -c src/oom.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/ctrl.o -c src/ctrl.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/ctr_stdio.o -c src/ctr_stdio.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/parent_pipe_fd.o -c src/parent_pipe_fd.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/ctr_exit.o -c src/ctr_exit.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/runtime_args.o -c src/runtime_args.c\ncc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/close_fds.o -c src/close_fds.c\ncc  -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o bin/conmon src/conmon.o src/cmsg.o src/ctr_logging.o src/utils.o src/cli.o src/globals.o src/cgroup.o src/conn_sock.o src/oom.o src/ctrl.o src/ctr_stdio.o src/parent_pipe_fd.o src/ctr_exit.o src/runtime_args.o src/close_fds.o -lglib-2.0  -lsystemd ", "stdout_lines": ["cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/conmon.o -c src/conmon.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/cmsg.o -c src/cmsg.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/ctr_logging.o -c src/ctr_logging.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/utils.o -c src/utils.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/cli.o -c src/cli.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/globals.o -c src/globals.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/cgroup.o -c src/cgroup.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/conn_sock.o -c src/conn_sock.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/oom.o -c src/oom.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/ctrl.o -c src/ctrl.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/ctr_stdio.o -c src/ctr_stdio.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/parent_pipe_fd.o -c src/parent_pipe_fd.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/ctr_exit.o -c src/ctr_exit.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/runtime_args.o -c src/runtime_args.c", "cc -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o src/close_fds.o -c src/close_fds.c", "cc  -std=c99 -Os -Wall -Wextra -Werror -I/usr/include/glib-2.0 -I/usr/lib64/glib-2.0/include  -DVERSION=\\\"2.0.27-dev\\\" -DGIT_COMMIT=\\\"\"c3f31c0671f6c84f5e02ec710385e1e8f2936066\"\\\"  -D USE_JOURNALD=0  -o bin/conmon src/conmon.o src/cmsg.o src/ctr_logging.o src/utils.o src/cli.o src/globals.o src/cgroup.o src/conn_sock.o src/oom.o src/ctrl.o src/ctr_stdio.o src/parent_pipe_fd.o src/ctr_exit.o src/runtime_args.o src/close_fds.o -lglib-2.0  -lsystemd "], "target": null}

TASK [install conmon] **********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/conmon.yml:13
redirecting (type: modules) ansible.builtin.make to community.general.make
changed: [localhost] => {"changed": true, "chdir": "/go/src/github.com/containers/conmon", "file": null, "params": {"PREFIX": "/"}, "stderr": "", "stderr_lines": [], "stdout": "install  -D -m 755 bin/conmon //bin/conmon\nmake -C tools\nmake[1]: Entering directory '/go/src/github.com/containers/conmon/tools'\nmake[1]: Leaving directory '/go/src/github.com/containers/conmon/tools'\n/usr/bin/gmake -C docs\ngmake[1]: Entering directory '/go/src/github.com/containers/conmon/docs'\n../tools/build/go-md2man -in conmon.8.md -out conmon.8\ngmake[1]: Leaving directory '/go/src/github.com/containers/conmon/docs'\n/usr/bin/gmake -C docs install\ngmake[1]: Entering directory '/go/src/github.com/containers/conmon/docs'\ninstall -d ///share/man/man8\ninstall -m 0644 conmon*.8 ///share/man/man8\ngmake[1]: Leaving directory '/go/src/github.com/containers/conmon/docs'", "stdout_lines": ["install  -D -m 755 bin/conmon //bin/conmon", "make -C tools", "make[1]: Entering directory '/go/src/github.com/containers/conmon/tools'", "make[1]: Leaving directory '/go/src/github.com/containers/conmon/tools'", "/usr/bin/gmake -C docs", "gmake[1]: Entering directory '/go/src/github.com/containers/conmon/docs'", "../tools/build/go-md2man -in conmon.8.md -out conmon.8", "gmake[1]: Leaving directory '/go/src/github.com/containers/conmon/docs'", "/usr/bin/gmake -C docs install", "gmake[1]: Entering directory '/go/src/github.com/containers/conmon/docs'", "install -d ///share/man/man8", "install -m 0644 conmon*.8 ///share/man/man8", "gmake[1]: Leaving directory '/go/src/github.com/containers/conmon/docs'"], "target": "install"}

TASK [install jq] **************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/jq.yml:2
ok: [localhost] => {"changed": false, "checksum_dest": "056ba5d6bbc617c29d37158ce11fd5a443093949", "checksum_src": "056ba5d6bbc617c29d37158ce11fd5a443093949", "dest": "/usr/bin/jq", "elapsed": 0, "gid": 0, "group": "root", "md5sum": "1fffde9f3c7944f063265e9a5e67ae4f", "mode": "0775", "msg": "OK (3953824 bytes)", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 3953824, "src": "/home/origin/.ansible/tmp/ansible-tmp-1638567690.1047935-11744-123936813889864/tmpZnWB7o", "state": "file", "status_code": 200, "uid": 0, "url": "https://github.com/stedolan/jq/releases/download/jq-1.6/jq-linux64"}

TASK [clone crun source repo] **************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:3
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [Install crun dependencies] ***********************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:10
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [Run autogen.sh] **********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:31
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [Run configure] ***********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:36
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [run crun clean] **********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:41
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [build crun] **************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:46
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [install crun] ************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:50
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [remove old runc binary] **************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:55
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [remove old runc binary under /usr/local/bin] *****************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:60
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [remove old runc binary under /usr/local/sbin] ****************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:65
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [crun state directory] ****************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:70
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [crun state directory] ****************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:75
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [link crun] ***************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:82
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [link crun to /usr/local/bin] *********************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/crun.yml:89
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [clone runc source repo] **************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/runc.yml:3
changed: [localhost] => {"after": "45c31f9e1f143f61733cc1357911e3a847870f21", "before": "06c1cd8896a910bc5cf4f86623dd85a9f9a558e0", "changed": true, "remote_url_changed": false}

TASK [build runc] **************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/runc.yml:9
redirecting (type: modules) ansible.builtin.make to community.general.make
changed: [localhost] => {"changed": true, "chdir": "/go/src/github.com/opencontainers/runc", "file": null, "params": {"BUILDTAGS": "seccomp selinux"}, "stderr": "", "stderr_lines": [], "stdout": "go build -trimpath \"-buildmode=pie\"  -tags \"seccomp selinux\" -ldflags \"-X main.gitCommit=v1.0.0-417-g45c31f9e -X main.version=1.0.0+dev \" -o runc .", "stdout_lines": ["go build -trimpath \"-buildmode=pie\"  -tags \"seccomp selinux\" -ldflags \"-X main.gitCommit=v1.0.0-417-g45c31f9e -X main.version=1.0.0+dev \" -o runc ."], "target": null}

TASK [install runc] ************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/runc.yml:14
redirecting (type: modules) ansible.builtin.make to community.general.make
changed: [localhost] => {"changed": true, "chdir": "/go/src/github.com/opencontainers/runc", "file": null, "params": null, "stderr": "", "stderr_lines": [], "stdout": "install -D -m0755 runc /usr/local/sbin/runc", "stdout_lines": ["install -D -m0755 runc /usr/local/sbin/runc"], "target": "install"}

TASK [link runc] ***************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/runc.yml:19
ok: [localhost] => {"changed": false, "dest": "/usr/bin/runc", "gid": 0, "group": "root", "mode": "0777", "owner": "root", "secontext": "unconfined_u:object_r:bin_t:s0", "size": 20, "src": "/usr/local/sbin/runc", "state": "link", "uid": 0}

TASK [retrieve kvm module name (x86_64 arch)] **********************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:4
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [retrieve kvm module name (s390x arch)] ***********************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:9
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [retrieve kvm module name (unknown arch)] *********************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:15
skipping: [localhost] => {}

TASK [set_fact] ****************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:19
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [ensure kvm module is loaded] *********************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:28
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [fail] ********************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:32
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [check nested virtualization is enabled] **********************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:38
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [unload kvm module] *******************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:44
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [load kvm module with parameters] *****************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:47
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [check nested virtualization activation] **********************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:50
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [fail] ********************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:54
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [install dnf-plugins-core] ************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:66
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [add Kata Containers repo] ************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:71
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [add Advanced Virtualization repo] ****************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:86
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [add the module_hotfixes option to the Advanced Virtualization repo] ******
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:97
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [add Kata Containers repo] ************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:102
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [install Kata Containers (old Fedora/CentOS versions)] ********************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:115
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [install Kata Containers] *************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:125
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [fix qemu binary in Kata Containers configuration file] *******************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:137
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [allow as many core as available to Qemu VM] ******************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kata.yml:144
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [set fs.may_detach_mounts = 1] ********************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/main.yml:103
redirecting (type: modules) ansible.builtin.sysctl to ansible.posix.sysctl
[WARNING]: The value "1" (type int) was converted to "u'1'" (type string). If
this does not look like what you expect, quote the entire value to ensure it
does not change.
ok: [localhost] => {"changed": false}
META: ran handlers
META: ran handlers

PLAY [all] *********************************************************************
META: ran handlers
META: ran handlers
META: ran handlers

PLAY [all] *********************************************************************
META: ran handlers
META: ran handlers
META: ran handlers

PLAY [all] *********************************************************************
META: ran handlers
META: ran handlers
META: ran handlers

PLAY [all] *********************************************************************

TASK [Gathering Facts] *********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/main.yml:166
ok: [localhost]
META: ran handlers

TASK [clone kubernetes source repo] ********************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:3
changed: [localhost] => {"after": "4eb01f4788f9ec9e0a92dc09cd70d0447572cac7", "before": "2fffed102ddbb65fd4a242c7d711cbd250d91fc1", "changed": true, "msg": "Local modifications exist.", "remote_url_changed": false}

TASK [use CRI stats] ***********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:12
changed: [localhost] => {"backup": "", "changed": true, "msg": "line replaced"}

TASK [install etcd] ************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:20
changed: [localhost] => {"changed": true, "cmd": ["hack/install-etcd.sh"], "delta": "0:00:00.133832", "end": "2021-12-03 21:43:14.475772", "rc": 0, "start": "2021-12-03 21:43:14.341940", "stderr": "", "stderr_lines": [], "stdout": "etcd v3.4.13 already installed. To use:\nexport PATH=\"/go/src/k8s.io/kubernetes/third_party/etcd:${PATH}\"", "stdout_lines": ["etcd v3.4.13 already installed. To use:", "export PATH=\"/go/src/k8s.io/kubernetes/third_party/etcd:${PATH}\""]}

TASK [build kubernetes] ********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:25
redirecting (type: modules) ansible.builtin.make to community.general.make
changed: [localhost] => {"changed": true, "chdir": "/go/src/k8s.io/kubernetes", "file": null, "params": null, "stderr": "", "stderr_lines": [], "stdout": "+++ [1203 21:43:14] Verifying Prerequisites....\n+++ [1203 21:43:15] Removing _output directory\nRemoving test/e2e/generated/bindata.go ..", "stdout_lines": ["+++ [1203 21:43:14] Verifying Prerequisites....", "+++ [1203 21:43:15] Removing _output directory", "Removing test/e2e/generated/bindata.go .."], "target": "clean"}

TASK [build kubernetes] ********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:30
redirecting (type: modules) ansible.builtin.make to community.general.make
changed: [localhost] => {"changed": true, "chdir": "/go/src/k8s.io/kubernetes", "file": null, "params": null, "stderr": "", "stderr_lines": [], "stdout": "+++ [1203 21:43:48] Building go targets for linux/amd64:\n    ./vendor/k8s.io/code-generator/cmd/prerelease-lifecycle-gen\nGenerating prerelease lifecycle code for 27 targets\n+++ [1203 21:43:52] Building go targets for linux/amd64:\n    ./vendor/k8s.io/code-generator/cmd/deepcopy-gen\nGenerating deepcopy code for 227 targets\n+++ [1203 21:44:00] Building go targets for linux/amd64:\n    ./vendor/k8s.io/code-generator/cmd/defaulter-gen\nGenerating defaulter code for 89 targets\n+++ [1203 21:44:10] Building go targets for linux/amd64:\n    ./vendor/k8s.io/code-generator/cmd/conversion-gen\nGenerating conversion code for 124 targets\n+++ [1203 21:44:31] Building go targets for linux/amd64:\n    ./vendor/k8s.io/kube-openapi/cmd/openapi-gen\nGenerating openapi code for KUBE\nGenerating openapi code for AGGREGATOR\nGenerating openapi code for APIEXTENSIONS\nGenerating openapi code for CODEGEN\nGenerating openapi code for SAMPLEAPISERVER\n+++ [1203 21:44:46] Building go targets for linux/amd64:\n    ./vendor/github.com/go-bindata/go-bindata/go-bindata\n+++ [1203 21:44:48] Building go targets for linux/amd64:\n    cmd/kube-proxy\n    cmd/kube-apiserver\n    cmd/kube-controller-manager\n    cmd/kubelet\n    cmd/kubeadm\n    cmd/kube-scheduler\n    vendor/k8s.io/kube-aggregator\n    vendor/k8s.io/apiextensions-apiserver\n    cluster/gce/gci/mounter\n    cmd/kubectl\n    cmd/kubectl-convert\n    cmd/gendocs\n    cmd/genkubedocs\n    cmd/genman\n    cmd/genyaml\n    cmd/genswaggertypedocs\n    cmd/linkcheck\n    vendor/github.com/onsi/ginkgo/ginkgo\n    test/e2e/e2e.test\n    cluster/images/conformance/go-runner\n    cmd/kubemark\n    vendor/github.com/onsi/ginkgo/ginkgo\n    test/e2e_node/e2e_node.test", "stdout_lines": ["+++ [1203 21:43:48] Building go targets for linux/amd64:", "    ./vendor/k8s.io/code-generator/cmd/prerelease-lifecycle-gen", "Generating prerelease lifecycle code for 27 targets", "+++ [1203 21:43:52] Building go targets for linux/amd64:", "    ./vendor/k8s.io/code-generator/cmd/deepcopy-gen", "Generating deepcopy code for 227 targets", "+++ [1203 21:44:00] Building go targets for linux/amd64:", "    ./vendor/k8s.io/code-generator/cmd/defaulter-gen", "Generating defaulter code for 89 targets", "+++ [1203 21:44:10] Building go targets for linux/amd64:", "    ./vendor/k8s.io/code-generator/cmd/conversion-gen", "Generating conversion code for 124 targets", "+++ [1203 21:44:31] Building go targets for linux/amd64:", "    ./vendor/k8s.io/kube-openapi/cmd/openapi-gen", "Generating openapi code for KUBE", "Generating openapi code for AGGREGATOR", "Generating openapi code for APIEXTENSIONS", "Generating openapi code for CODEGEN", "Generating openapi code for SAMPLEAPISERVER", "+++ [1203 21:44:46] Building go targets for linux/amd64:", "    ./vendor/github.com/go-bindata/go-bindata/go-bindata", "+++ [1203 21:44:48] Building go targets for linux/amd64:", "    cmd/kube-proxy", "    cmd/kube-apiserver", "    cmd/kube-controller-manager", "    cmd/kubelet", "    cmd/kubeadm", "    cmd/kube-scheduler", "    vendor/k8s.io/kube-aggregator", "    vendor/k8s.io/apiextensions-apiserver", "    cluster/gce/gci/mounter", "    cmd/kubectl", "    cmd/kubectl-convert", "    cmd/gendocs", "    cmd/genkubedocs", "    cmd/genman", "    cmd/genyaml", "    cmd/genswaggertypedocs", "    cmd/linkcheck", "    vendor/github.com/onsi/ginkgo/ginkgo", "    test/e2e/e2e.test", "    cluster/images/conformance/go-runner", "    cmd/kubemark", "    vendor/github.com/onsi/ginkgo/ginkgo", "    test/e2e_node/e2e_node.test"], "target": null}

TASK [Add custom cluster service file for the e2e testing] *********************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:34
ok: [localhost] => {"changed": false, "checksum": "6eac4634e0e56cc8e358e785bac2ce8939e438f2", "dest": "/etc/systemd/system/customcluster.service", "gid": 0, "group": "root", "mode": "0644", "owner": "root", "path": "/etc/systemd/system/customcluster.service", "secontext": "system_u:object_r:systemd_unit_file_t:s0", "size": 205, "state": "file", "uid": 0}

TASK [Add create cluster background script for e2e testing] ********************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:48
changed: [localhost] => {"changed": true, "checksum": "956b8865bcbeeb8f1357bb22df205b594b974f80", "dest": "/usr/local/bin/createcluster.sh", "gid": 0, "group": "root", "md5sum": "6bcdd1fb41331131a235e83ae445cb39", "mode": "0771", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 1058, "src": "/home/origin/.ansible/tmp/ansible-tmp-1638568602.3744957-27576-218592193892768/source", "state": "file", "uid": 0}

TASK [Set kubernetes_provider to be local] *************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:77
changed: [localhost] => {"backup": "", "changed": true, "msg": "line replaced"}

TASK [Set KUBECONFIG] **********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:86
changed: [localhost] => {"backup": "", "changed": true, "msg": "line replaced"}

TASK [install kubectl (for kubetest)] ******************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:95
changed: [localhost] => {"changed": true, "checksum": "f23b03807784052496f85158cc3b1e90fd941675", "dest": "/go/bin/kubectl", "gid": 0, "group": "root", "md5sum": "fcd3a86feb2802601e954412c8ecf238", "mode": "0755", "owner": "root", "secontext": "system_u:object_r:default_t:s0", "size": 44818432, "src": "/home/origin/.ansible/tmp/ansible-tmp-1638568603.1890385-27644-248233381700615/source", "state": "file", "uid": 0}

TASK [clone kubernetes source repo] ********************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:3
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [use CRI stats] ***********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:12
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [install etcd] ************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:20
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [build kubernetes] ********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:25
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [build kubernetes] ********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:30
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [Add custom cluster service file for the e2e testing] *********************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:34
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [Add create cluster background script for e2e testing] ********************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:48
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [Set kubernetes_provider to be local] *************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:77
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [Set KUBECONFIG] **********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:86
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [install kubectl (for kubetest)] ******************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:95
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [clone test-infra source repo] ********************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubetest.yml:3
changed: [localhost] => {"after": "bc1b35a663ae0905347ade0a2bac2aee7c4e1e1c", "before": "8c724915ffbb8b63241931f214b30d09913a8051", "changed": true, "remote_url_changed": false}

TASK [install kubetest] ********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubetest.yml:13
changed: [localhost] => {"changed": true, "cmd": "GOPROXY=https://proxy.golang.org GOSUMDB=sum.golang.org GO111MODULE=on go get ./kubetest", "delta": "0:01:14.327891", "end": "2021-12-03 21:58:18.149350", "rc": 0, "start": "2021-12-03 21:57:03.821459", "stderr": "go: downloading cloud.google.com/go v0.81.0\ngo: downloading github.com/Azure/go-autorest/autorest v0.11.12\ngo: downloading github.com/aws/aws-sdk-go v1.37.22\ngo: downloading github.com/pelletier/go-toml v1.9.3\ngo: downloading golang.org/x/crypto v0.0.0-20210220033148-5ea612d1eb83\ngo: downloading sigs.k8s.io/boskos v0.0.0-20210730172138-093b54882439\ngo: downloading google.golang.org/api v0.44.0\ngo: downloading google.golang.org/genproto v0.0.0-20210602131652-f16073e35f0c\ngo: downloading k8s.io/api v0.21.3\ngo: downloading k8s.io/apimachinery v0.21.3\ngo: downloading k8s.io/client-go v0.21.1\ngo: downloading github.com/google/uuid v1.2.0\ngo: downloading github.com/sirupsen/logrus v1.8.1\ngo: downloading github.com/golang/protobuf v1.5.2\ngo: downloading golang.org/x/tools v0.1.5\ngo: downloading google.golang.org/grpc v1.38.0\ngo: downloading go.opencensus.io v0.23.0\ngo: downloading golang.org/x/oauth2 v0.0.0-20210402161424-2e8d93401602\ngo: downloading google.golang.org/appengine v1.6.7\ngo: downloading golang.org/x/sys v0.0.0-20210603081109-ebe580a85c40\ngo: downloading github.com/gogo/protobuf v1.3.2\ngo: downloading github.com/google/gofuzz v1.2.1-0.20210504230335-f78f29fc09ea\ngo: downloading github.com/imdario/mergo v0.3.12\ngo: downloading golang.org/x/term v0.0.0-20210220032956-6a3ed077a48d\ngo: downloading k8s.io/klog/v2 v2.8.0\ngo: downloading google.golang.org/protobuf v1.26.0\ngo: downloading github.com/jmespath/go-jmespath v0.4.0\ngo: downloading github.com/google/go-cmp v0.5.6\ngo: downloading sigs.k8s.io/structured-merge-diff/v4 v4.1.2\ngo: downloading golang.org/x/time v0.0.0-20210220033141-f8bda1e9f3ba\ngo: downloading k8s.io/utils v0.0.0-20210527160623-6fdb442a123b\ngo: downloading github.com/go-logr/logr v0.4.0\ngo: downloading go4.org v0.0.0-20201209231011-d4a079459e60\ngo: downloading golang.org/x/mod v0.4.2\ngo: downloading github.com/json-iterator/go v1.1.11\ngo: downloading github.com/prometheus/client_golang v1.11.0\ngo: downloading github.com/prometheus/common v0.26.0\ngo: downloading github.com/prometheus/procfs v0.6.0", "stderr_lines": ["go: downloading cloud.google.com/go v0.81.0", "go: downloading github.com/Azure/go-autorest/autorest v0.11.12", "go: downloading github.com/aws/aws-sdk-go v1.37.22", "go: downloading github.com/pelletier/go-toml v1.9.3", "go: downloading golang.org/x/crypto v0.0.0-20210220033148-5ea612d1eb83", "go: downloading sigs.k8s.io/boskos v0.0.0-20210730172138-093b54882439", "go: downloading google.golang.org/api v0.44.0", "go: downloading google.golang.org/genproto v0.0.0-20210602131652-f16073e35f0c", "go: downloading k8s.io/api v0.21.3", "go: downloading k8s.io/apimachinery v0.21.3", "go: downloading k8s.io/client-go v0.21.1", "go: downloading github.com/google/uuid v1.2.0", "go: downloading github.com/sirupsen/logrus v1.8.1", "go: downloading github.com/golang/protobuf v1.5.2", "go: downloading golang.org/x/tools v0.1.5", "go: downloading google.golang.org/grpc v1.38.0", "go: downloading go.opencensus.io v0.23.0", "go: downloading golang.org/x/oauth2 v0.0.0-20210402161424-2e8d93401602", "go: downloading google.golang.org/appengine v1.6.7", "go: downloading golang.org/x/sys v0.0.0-20210603081109-ebe580a85c40", "go: downloading github.com/gogo/protobuf v1.3.2", "go: downloading github.com/google/gofuzz v1.2.1-0.20210504230335-f78f29fc09ea", "go: downloading github.com/imdario/mergo v0.3.12", "go: downloading golang.org/x/term v0.0.0-20210220032956-6a3ed077a48d", "go: downloading k8s.io/klog/v2 v2.8.0", "go: downloading google.golang.org/protobuf v1.26.0", "go: downloading github.com/jmespath/go-jmespath v0.4.0", "go: downloading github.com/google/go-cmp v0.5.6", "go: downloading sigs.k8s.io/structured-merge-diff/v4 v4.1.2", "go: downloading golang.org/x/time v0.0.0-20210220033141-f8bda1e9f3ba", "go: downloading k8s.io/utils v0.0.0-20210527160623-6fdb442a123b", "go: downloading github.com/go-logr/logr v0.4.0", "go: downloading go4.org v0.0.0-20201209231011-d4a079459e60", "go: downloading golang.org/x/mod v0.4.2", "go: downloading github.com/json-iterator/go v1.1.11", "go: downloading github.com/prometheus/client_golang v1.11.0", "go: downloading github.com/prometheus/common v0.26.0", "go: downloading github.com/prometheus/procfs v0.6.0"], "stdout": "", "stdout_lines": []}

TASK [add test-handler runtime handler for Runtimes test] **********************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-base.yml:3
changed: [localhost] => {"changed": true, "msg": "Block inserted"}

TASK [create ssh keys] *********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-base.yml:14
changed: [localhost] => {"changed": true, "cmd": "ssh-keygen -b 2048 -t rsa -f \"/home/origin/.ssh/id_rsa\" -q -N \"\"", "delta": "0:00:00.159143", "end": "2021-12-03 21:58:18.933657", "rc": 0, "start": "2021-12-03 21:58:18.774514", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}

TASK [add key file to authorized_users] ****************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-base.yml:19
redirecting (type: modules) ansible.builtin.authorized_key to ansible.posix.authorized_key
changed: [localhost] => {"changed": true, "comment": null, "exclusive": false, "follow": false, "key": "ssh-rsa AAAAB3NzaC1yc2EAAAADAQABAAABAQDZj5B/DkyVU7SMsdz2CjkAA34/eHL4JjWkUFzUrs+05LG5HOMY8q9BFtew6i8DTinXe4rSy14EBJl1poeQA6RFyKJgf+IB4TWUwOsEULwNA7XGKq9VrnpIJcZQDtht+80qWMIbA16E/5jUd7wt3wHmsSvCZBWNPsd/WuKIiAweEu6hXauotvU4t/Y8rBnfBBbmQiWQc8HEdyIwc1RRbVQbdZHNa2tJPotxkvV7OWL8YWkOgxd8AZQYgwiuLuijKqSASxJUJvsXbTLQlbt/yN9Cu8KbXx8uqSyJ8NglMbEUMa5K2yjHR0I2onGuH9P5MAzhTVjev6531RIHbLvjN++X root@ip-172-18-4-214.ec2.internal ", "key_options": null, "keyfile": "/home/origin/.ssh/authorized_keys", "manage_dir": true, "path": null, "state": "present", "user": "origin", "validate_certs": true}

TASK [enable and start CRI-O] **************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-base.yml:25
changed: [localhost] => {"changed": true, "enabled": true, "name": "crio", "state": "started", "status": {"ActiveEnterTimestampMonotonic": "0", "ActiveExitTimestampMonotonic": "0", "ActiveState": "inactive", "After": "sysinit.target system.slice basic.target network-online.target systemd-journald.socket", "AllowIsolate": "no", "AmbientCapabilities": "", "AssertResult": "no", "AssertTimestampMonotonic": "0", "Before": "kubelet.service shutdown.target", "BlockIOAccounting": "no", "BlockIOWeight": "[not set]", "CPUAccounting": "no", "CPUQuotaPerSecUSec": "infinity", "CPUSchedulingPolicy": "0", "CPUSchedulingPriority": "0", "CPUSchedulingResetOnFork": "no", "CPUShares": "[not set]", "CPUUsageNSec": "[not set]", "CPUWeight": "[not set]", "CacheDirectoryMode": "0755", "CanIsolate": "no", "CanReload": "yes", "CanStart": "yes", "CanStop": "yes", "CapabilityBoundingSet": "cap_chown cap_dac_override cap_dac_read_search cap_fowner cap_fsetid cap_kill cap_setgid cap_setuid cap_setpcap cap_linux_immutable cap_net_bind_service cap_net_broadcast cap_net_admin cap_net_raw cap_ipc_lock cap_ipc_owner cap_sys_module cap_sys_rawio cap_sys_chroot cap_sys_ptrace cap_sys_pacct cap_sys_admin cap_sys_boot cap_sys_nice cap_sys_resource cap_sys_time cap_sys_tty_config cap_mknod cap_lease cap_audit_write cap_audit_control cap_setfcap cap_mac_override cap_mac_admin cap_syslog cap_wake_alarm cap_block_suspend cap_audit_read", "CollectMode": "inactive", "ConditionResult": "no", "ConditionTimestampMonotonic": "0", "ConfigurationDirectoryMode": "0755", "Conflicts": "shutdown.target", "ControlPID": "0", "DefaultDependencies": "yes", "Delegate": "no", "Description": "Container Runtime Interface for OCI (CRI-O)", "DevicePolicy": "auto", "Documentation": "https://github.com/cri-o/cri-o", "DynamicUser": "no", "Environment": "GOTRACEBACK=crash", "EnvironmentFiles": "/etc/sysconfig/crio (ignore_errors=yes)", "ExecMainCode": "0", "ExecMainExitTimestampMonotonic": "0", "ExecMainPID": "0", "ExecMainStartTimestampMonotonic": "0", "ExecMainStatus": "0", "ExecReload": "{ path=/bin/kill ; argv[]=/bin/kill -s HUP $MAINPID ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "ExecStart": "{ path=/usr/local/bin/crio ; argv[]=/usr/local/bin/crio $CRIO_CONFIG_OPTIONS $CRIO_RUNTIME_OPTIONS $CRIO_STORAGE_OPTIONS $CRIO_NETWORK_OPTIONS $CRIO_METRICS_OPTIONS ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "FailureAction": "none", "FailureActionExitStatus": "-1", "FileDescriptorStoreMax": "0", "FinalKillSignal": "9", "FragmentPath": "/usr/local/lib/systemd/system/crio.service", "GID": "[not set]", "GuessMainPID": "yes", "IOAccounting": "no", "IOSchedulingClass": "0", "IOSchedulingPriority": "0", "IOWeight": "[not set]", "IPAccounting": "no", "IPEgressBytes": "18446744073709551615", "IPEgressPackets": "18446744073709551615", "IPIngressBytes": "18446744073709551615", "IPIngressPackets": "18446744073709551615", "Id": "crio.service", "IgnoreOnIsolate": "no", "IgnoreSIGPIPE": "yes", "InactiveEnterTimestampMonotonic": "0", "InactiveExitTimestampMonotonic": "0", "JobRunningTimeoutUSec": "infinity", "JobTimeoutAction": "none", "JobTimeoutUSec": "infinity", "KeyringMode": "private", "KillMode": "control-group", "KillSignal": "15", "LimitAS": "infinity", "LimitASSoft": "infinity", "LimitCORE": "infinity", "LimitCORESoft": "infinity", "LimitCPU": "infinity", "LimitCPUSoft": "infinity", "LimitDATA": "infinity", "LimitDATASoft": "infinity", "LimitFSIZE": "infinity", "LimitFSIZESoft": "infinity", "LimitLOCKS": "infinity", "LimitLOCKSSoft": "infinity", "LimitMEMLOCK": "65536", "LimitMEMLOCKSoft": "65536", "LimitMSGQUEUE": "819200", "LimitMSGQUEUESoft": "819200", "LimitNICE": "0", "LimitNICESoft": "0", "LimitNOFILE": "1048576", "LimitNOFILESoft": "1048576", "LimitNPROC": "1048576", "LimitNPROCSoft": "1048576", "LimitRSS": "infinity", "LimitRSSSoft": "infinity", "LimitRTPRIO": "0", "LimitRTPRIOSoft": "0", "LimitRTTIME": "infinity", "LimitRTTIMESoft": "infinity", "LimitSIGPENDING": "63865", "LimitSIGPENDINGSoft": "63865", "LimitSTACK": "infinity", "LimitSTACKSoft": "8388608", "LoadState": "loaded", "LockPersonality": "no", "LogLevelMax": "-1", "LogRateLimitBurst": "0", "LogRateLimitIntervalUSec": "0", "LogsDirectoryMode": "0755", "MainPID": "0", "MemoryAccounting": "yes", "MemoryCurrent": "[not set]", "MemoryDenyWriteExecute": "no", "MemoryHigh": "infinity", "MemoryLimit": "infinity", "MemoryLow": "0", "MemoryMax": "infinity", "MemoryMin": "0", "MemorySwapMax": "infinity", "MountAPIVFS": "no", "MountFlags": "", "NFileDescriptorStore": "0", "NRestarts": "0", "Names": "crio.service", "NeedDaemonReload": "no", "Nice": "0", "NoNewPrivileges": "no", "NonBlocking": "no", "NotifyAccess": "main", "OOMScoreAdjust": "-999", "OnFailureJobMode": "replace", "Perpetual": "no", "PrivateDevices": "no", "PrivateMounts": "no", "PrivateNetwork": "no", "PrivateTmp": "no", "PrivateUsers": "no", "ProtectControlGroups": "no", "ProtectHome": "no", "ProtectKernelModules": "no", "ProtectKernelTunables": "no", "ProtectSystem": "no", "RefuseManualStart": "no", "RefuseManualStop": "no", "RemainAfterExit": "no", "RemoveIPC": "no", "Requires": "system.slice sysinit.target", "Restart": "no", "RestartUSec": "100ms", "RestrictNamespaces": "no", "RestrictRealtime": "no", "RestrictSUIDSGID": "no", "Result": "success", "RootDirectoryStartOnly": "no", "RuntimeDirectoryMode": "0755", "RuntimeDirectoryPreserve": "no", "RuntimeMaxUSec": "infinity", "SameProcessGroup": "no", "SecureBits": "0", "SendSIGHUP": "no", "SendSIGKILL": "yes", "Slice": "system.slice", "StandardError": "inherit", "StandardInput": "null", "StandardInputData": "", "StandardOutput": "journal", "StartLimitAction": "none", "StartLimitBurst": "5", "StartLimitIntervalUSec": "10s", "StartupBlockIOWeight": "[not set]", "StartupCPUShares": "[not set]", "StartupCPUWeight": "[not set]", "StartupIOWeight": "[not set]", "StateChangeTimestampMonotonic": "0", "StateDirectoryMode": "0755", "StatusErrno": "0", "StopWhenUnneeded": "no", "SubState": "dead", "SuccessAction": "none", "SuccessActionExitStatus": "-1", "SyslogFacility": "3", "SyslogLevel": "6", "SyslogLevelPrefix": "yes", "SyslogPriority": "30", "SystemCallErrorNumber": "0", "TTYReset": "no", "TTYVHangup": "no", "TTYVTDisallocate": "no", "TasksAccounting": "yes", "TasksCurrent": "[not set]", "TasksMax": "infinity", "TimeoutStartUSec": "infinity", "TimeoutStopUSec": "1min 30s", "TimerSlackNSec": "50000", "Transient": "no", "Type": "notify", "UID": "[not set]", "UMask": "0022", "UnitFilePreset": "disabled", "UnitFileState": "disabled", "UtmpMode": "init", "Wants": "network-online.target", "WatchdogSignal": "6", "WatchdogTimestampMonotonic": "0", "WatchdogUSec": "0"}}

TASK [update the server address for the custom cluster] ************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-base.yml:32
changed: [localhost] => (item=DNS_SERVER_IP) => {"ansible_loop_var": "item", "backup": "", "changed": true, "item": "DNS_SERVER_IP", "msg": "line replaced"}
changed: [localhost] => (item=API_HOST) => {"ansible_loop_var": "item", "backup": "", "changed": true, "item": "API_HOST", "msg": "line replaced"}
changed: [localhost] => (item=API_HOST_IP) => {"ansible_loop_var": "item", "backup": "", "changed": true, "item": "API_HOST_IP", "msg": "line replaced"}

TASK [enable and start the custom cluster] *************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-base.yml:45
changed: [localhost] => {"changed": true, "enabled": true, "name": "customcluster.service", "state": "started", "status": {"ActiveEnterTimestampMonotonic": "0", "ActiveExitTimestampMonotonic": "0", "ActiveState": "inactive", "After": "network-online.target systemd-journald.socket sysinit.target basic.target -.mount system.slice", "AllowIsolate": "no", "AmbientCapabilities": "", "AssertResult": "no", "AssertTimestampMonotonic": "0", "Before": "shutdown.target", "BlockIOAccounting": "no", "BlockIOWeight": "[not set]", "CPUAccounting": "no", "CPUQuotaPerSecUSec": "infinity", "CPUSchedulingPolicy": "0", "CPUSchedulingPriority": "0", "CPUSchedulingResetOnFork": "no", "CPUShares": "[not set]", "CPUUsageNSec": "[not set]", "CPUWeight": "[not set]", "CacheDirectoryMode": "0755", "CanIsolate": "no", "CanReload": "no", "CanStart": "yes", "CanStop": "yes", "CapabilityBoundingSet": "cap_chown cap_dac_override cap_dac_read_search cap_fowner cap_fsetid cap_kill cap_setgid cap_setuid cap_setpcap cap_linux_immutable cap_net_bind_service cap_net_broadcast cap_net_admin cap_net_raw cap_ipc_lock cap_ipc_owner cap_sys_module cap_sys_rawio cap_sys_chroot cap_sys_ptrace cap_sys_pacct cap_sys_admin cap_sys_boot cap_sys_nice cap_sys_resource cap_sys_time cap_sys_tty_config cap_mknod cap_lease cap_audit_write cap_audit_control cap_setfcap cap_mac_override cap_mac_admin cap_syslog cap_wake_alarm cap_block_suspend cap_audit_read", "CollectMode": "inactive", "ConditionResult": "no", "ConditionTimestampMonotonic": "0", "ConfigurationDirectoryMode": "0755", "Conflicts": "shutdown.target", "ControlPID": "0", "DefaultDependencies": "yes", "Delegate": "no", "Description": "customcluster.service", "DevicePolicy": "auto", "DynamicUser": "no", "ExecMainCode": "0", "ExecMainExitTimestampMonotonic": "0", "ExecMainPID": "0", "ExecMainStartTimestampMonotonic": "0", "ExecMainStatus": "0", "ExecStart": "{ path=/usr/local/bin/createcluster.sh ; argv[]=/usr/local/bin/createcluster.sh ; ignore_errors=no ; start_time=[n/a] ; stop_time=[n/a] ; pid=0 ; code=(null) ; status=0/0 }", "FailureAction": "none", "FailureActionExitStatus": "-1", "FileDescriptorStoreMax": "0", "FinalKillSignal": "9", "FragmentPath": "/etc/systemd/system/customcluster.service", "GID": "[not set]", "GuessMainPID": "yes", "IOAccounting": "no", "IOSchedulingClass": "0", "IOSchedulingPriority": "0", "IOWeight": "[not set]", "IPAccounting": "no", "IPEgressBytes": "18446744073709551615", "IPEgressPackets": "18446744073709551615", "IPIngressBytes": "18446744073709551615", "IPIngressPackets": "18446744073709551615", "Id": "customcluster.service", "IgnoreOnIsolate": "no", "IgnoreSIGPIPE": "yes", "InactiveEnterTimestampMonotonic": "0", "InactiveExitTimestampMonotonic": "0", "JobRunningTimeoutUSec": "infinity", "JobTimeoutAction": "none", "JobTimeoutUSec": "infinity", "KeyringMode": "private", "KillMode": "control-group", "KillSignal": "15", "LimitAS": "infinity", "LimitASSoft": "infinity", "LimitCORE": "infinity", "LimitCORESoft": "infinity", "LimitCPU": "infinity", "LimitCPUSoft": "infinity", "LimitDATA": "infinity", "LimitDATASoft": "infinity", "LimitFSIZE": "infinity", "LimitFSIZESoft": "infinity", "LimitLOCKS": "infinity", "LimitLOCKSSoft": "infinity", "LimitMEMLOCK": "65536", "LimitMEMLOCKSoft": "65536", "LimitMSGQUEUE": "819200", "LimitMSGQUEUESoft": "819200", "LimitNICE": "0", "LimitNICESoft": "0", "LimitNOFILE": "524288", "LimitNOFILESoft": "1024", "LimitNPROC": "63865", "LimitNPROCSoft": "63865", "LimitRSS": "infinity", "LimitRSSSoft": "infinity", "LimitRTPRIO": "0", "LimitRTPRIOSoft": "0", "LimitRTTIME": "infinity", "LimitRTTIMESoft": "infinity", "LimitSIGPENDING": "63865", "LimitSIGPENDINGSoft": "63865", "LimitSTACK": "infinity", "LimitSTACKSoft": "8388608", "LoadState": "loaded", "LockPersonality": "no", "LogLevelMax": "-1", "LogRateLimitBurst": "0", "LogRateLimitIntervalUSec": "0", "LogsDirectoryMode": "0755", "MainPID": "0", "MemoryAccounting": "yes", "MemoryCurrent": "[not set]", "MemoryDenyWriteExecute": "no", "MemoryHigh": "infinity", "MemoryLimit": "infinity", "MemoryLow": "0", "MemoryMax": "infinity", "MemoryMin": "0", "MemorySwapMax": "infinity", "MountAPIVFS": "no", "MountFlags": "", "NFileDescriptorStore": "0", "NRestarts": "0", "Names": "customcluster.service", "NeedDaemonReload": "no", "Nice": "0", "NoNewPrivileges": "no", "NonBlocking": "no", "NotifyAccess": "none", "OOMScoreAdjust": "0", "OnFailureJobMode": "replace", "Perpetual": "no", "PrivateDevices": "no", "PrivateMounts": "no", "PrivateNetwork": "no", "PrivateTmp": "no", "PrivateUsers": "no", "ProtectControlGroups": "no", "ProtectHome": "no", "ProtectKernelModules": "no", "ProtectKernelTunables": "no", "ProtectSystem": "no", "RefuseManualStart": "no", "RefuseManualStop": "no", "RemainAfterExit": "no", "RemoveIPC": "no", "Requires": "-.mount system.slice sysinit.target", "RequiresMountsFor": "/go/src/k8s.io/kubernetes", "Restart": "no", "RestartUSec": "100ms", "RestrictNamespaces": "no", "RestrictRealtime": "no", "RestrictSUIDSGID": "no", "Result": "success", "RootDirectoryStartOnly": "no", "RuntimeDirectoryMode": "0755", "RuntimeDirectoryPreserve": "no", "RuntimeMaxUSec": "infinity", "SameProcessGroup": "no", "SecureBits": "0", "SendSIGHUP": "no", "SendSIGKILL": "yes", "Slice": "system.slice", "StandardError": "inherit", "StandardInput": "null", "StandardInputData": "", "StandardOutput": "journal", "StartLimitAction": "none", "StartLimitBurst": "5", "StartLimitIntervalUSec": "10s", "StartupBlockIOWeight": "[not set]", "StartupCPUShares": "[not set]", "StartupCPUWeight": "[not set]", "StartupIOWeight": "[not set]", "StateChangeTimestampMonotonic": "0", "StateDirectoryMode": "0755", "StatusErrno": "0", "StopWhenUnneeded": "no", "SubState": "dead", "SuccessAction": "none", "SuccessActionExitStatus": "-1", "SyslogFacility": "3", "SyslogLevel": "6", "SyslogLevelPrefix": "yes", "SyslogPriority": "30", "SystemCallErrorNumber": "0", "TTYReset": "no", "TTYVHangup": "no", "TTYVTDisallocate": "no", "TasksAccounting": "yes", "TasksCurrent": "[not set]", "TasksMax": "4915", "TimeoutStartUSec": "1min 30s", "TimeoutStopUSec": "1min 30s", "TimerSlackNSec": "50000", "Transient": "no", "Type": "simple", "UID": "[not set]", "UMask": "0022", "UnitFilePreset": "disabled", "UnitFileState": "disabled", "User": "root", "UtmpMode": "init", "Wants": "network-online.target", "WatchdogSignal": "6", "WatchdogTimestampMonotonic": "0", "WatchdogUSec": "0", "WorkingDirectory": "/go/src/k8s.io/kubernetes"}}

TASK [wait for the cluster to be running] **************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-base.yml:52
FAILED - RETRYING: wait for the cluster to be running (100 retries left).
FAILED - RETRYING: wait for the cluster to be running (99 retries left).
FAILED - RETRYING: wait for the cluster to be running (98 retries left).
changed: [localhost] => {"attempts": 4, "changed": true, "cmd": "/go/src/k8s.io/kubernetes/_output/bin/kubectl get nodes -o jsonpath='{range .items[*]}{@.metadata.name}:{range @.status.conditions[*]}{@.type}={@.status};{end}{end}' 2>&1 | grep 'Ready=True'", "delta": "0:00:00.081815", "end": "2021-12-03 21:59:55.959516", "rc": 0, "start": "2021-12-03 21:59:55.877701", "stderr": "", "stderr_lines": [], "stdout": "172.18.4.214:MemoryPressure=False;DiskPressure=False;PIDPressure=False;Ready=True;", "stdout_lines": ["172.18.4.214:MemoryPressure=False;DiskPressure=False;PIDPressure=False;Ready=True;"]}

TASK [ensure directory exists for e2e reports] *********************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-base.yml:60
changed: [localhost] => {"changed": true, "gid": 0, "group": "root", "mode": "0755", "owner": "root", "path": "/tmp/artifacts", "secontext": "unconfined_u:object_r:user_tmp_t:s0", "size": 4096, "state": "directory", "uid": 0}

TASK [upgrade git package] *****************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-base.yml:65
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [load br_netfilter module] ************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-base.yml:71
changed: [localhost] => {"changed": true, "cmd": ["modprobe", "br_netfilter"], "delta": "0:00:00.018827", "end": "2021-12-03 21:59:56.453960", "rc": 0, "start": "2021-12-03 21:59:56.435133", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}

TASK [Enable iptables NAT for the bridge] **************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-base.yml:74
redirecting (type: modules) ansible.builtin.sysctl to ansible.posix.sysctl
changed: [localhost] => {"changed": true}

TASK [Buffer the e2e testing command to workaround Ansible YAML folding "feature"] ***
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-features.yml:6
ok: [localhost] => {"ansible_facts": {"e2e_shell_cmd": "KUBE_CONTAINER_RUNTIME=\"remote\" GINKGO_PARALLEL_NODES=6 GINKGO_PARALLEL=y\n    \"/go\"/bin/kubetest\n    --provider=local\n    --test\n    --test_args=\"-host=https://172.18.4.214:6443\n                --ginkgo.noColor\n                --ginkgo.succinct\n                --ginkgo.focus=\\[NodeFeature:.*\\]|\\[Feature:(Seccomp|ScopeSelectors|PodPriority|Ingress|ComprehensiveNamespaceDraining|Networking-IPv4|TokenRequestProjection)\\]\n                --ginkgo.skip=\\\\[Slow\\\\]|\\\\[Flaky\\\\]|\\\\[Serial\\\\]\n                --report-dir=/tmp/artifacts\"\n    &> /tmp/artifacts/e2e.log\n"}, "changed": false}

TASK [Disable selinux during e2e tests] ****************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-features.yml:29
changed: [localhost] => {"changed": true, "cmd": ["setenforce", "0"], "delta": "0:00:00.005379", "end": "2021-12-03 21:59:56.930827", "rc": 0, "start": "2021-12-03 21:59:56.925448", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}

TASK [run e2e tests] ***********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-features.yml:33
changed: [localhost] => {"ansible_job_id": "505369129232.3256", "changed": true, "cmd": "KUBE_CONTAINER_RUNTIME=\"remote\" GINKGO_PARALLEL_NODES=6 GINKGO_PARALLEL=y \"/go\"/bin/kubetest --provider=local --test --test_args=\"-host=https://172.18.4.214:6443 --ginkgo.noColor --ginkgo.succinct --ginkgo.focus=\\[NodeFeature:.*\\]|\\[Feature:(Seccomp|ScopeSelectors|PodPriority|Ingress|ComprehensiveNamespaceDraining|Networking-IPv4|TokenRequestProjection)\\] --ginkgo.skip=\\\\[Slow\\\\]|\\\\[Flaky\\\\]|\\\\[Serial\\\\] --report-dir=/tmp/artifacts\" &> /tmp/artifacts/e2e.log ", "delta": "0:01:03.158276", "end": "2021-12-03 22:01:00.568222", "finished": 1, "rc": 0, "start": "2021-12-03 21:59:57.409946", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}

TASK [Re-enable SELinux after e2e tests] ***************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/e2e-features.yml:42
changed: [localhost] => {"changed": true, "cmd": ["setenforce", "1"], "delta": "0:00:00.008926", "end": "2021-12-03 22:01:58.149376", "rc": 0, "start": "2021-12-03 22:01:58.140450", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}
META: ran handlers
META: ran handlers

PLAY RECAP *********************************************************************
localhost                  : ok=54   changed=44   unreachable=0    failed=0    skipped=48   rescued=0    ignored=0   

+ set +o xtrace
########## FINISHED STAGE: SUCCESS: RUN THE CRI-O E2E FEATURES TESTS [00h 24m 05s] ##########
[PostBuildScript] - [INFO] Executing post build scripts.
[workspace] $ /bin/bash /tmp/jenkins4548570289627750654.sh
########## STARTING STAGE: DOWNLOAD ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /go/src/k8s.io/kubernetes/artifacts
stat: cannot stat '/go/src/k8s.io/kubernetes/artifacts': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /go/src/k8s.io/kubernetes/e2e.log
stat: cannot stat '/go/src/k8s.io/kubernetes/e2e.log': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /go/src/github.com/cri-o/cri-o/testout.txt
stat: cannot stat '/go/src/github.com/cri-o/cri-o/testout.txt': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /go/src/github.com/cri-o/cri-o/reports
stat: cannot stat '/go/src/github.com/cri-o/cri-o/reports': No such file or directory
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat '/tmp/artifacts/*'
  File: /tmp/artifacts/e2e.log
  Size: 161195    	Blocks: 328        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 274372      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-12-03 21:59:57.412062011 +0000
Modify: 2021-12-03 22:01:00.564379759 +0000
Change: 2021-12-03 22:01:00.564379759 +0000
 Birth: 2021-12-03 21:59:57.412062011 +0000
  File: /tmp/artifacts/junit_01.xml
  Size: 127415    	Blocks: 256        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 274378      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-12-03 22:01:00.542379997 +0000
Modify: 2021-12-03 22:01:00.544379975 +0000
Change: 2021-12-03 22:01:00.544379975 +0000
 Birth: 2021-12-03 22:01:00.542379997 +0000
  File: /tmp/artifacts/junit_02.xml
  Size: 233368    	Blocks: 456        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 274377      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-12-03 22:01:00.475380721 +0000
Modify: 2021-12-03 22:01:00.479380678 +0000
Change: 2021-12-03 22:01:00.479380678 +0000
 Birth: 2021-12-03 22:01:00.475380721 +0000
  File: /tmp/artifacts/junit_03.xml
  Size: 344222    	Blocks: 680        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 274373      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-12-03 22:00:44.878549215 +0000
Modify: 2021-12-03 22:00:44.889549096 +0000
Change: 2021-12-03 22:00:44.889549096 +0000
 Birth: 2021-12-03 22:00:44.878549215 +0000
  File: /tmp/artifacts/junit_04.xml
  Size: 366778    	Blocks: 720        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 274374      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-12-03 22:00:45.226545456 +0000
Modify: 2021-12-03 22:00:45.234545370 +0000
Change: 2021-12-03 22:00:45.234545370 +0000
 Birth: 2021-12-03 22:00:45.226545456 +0000
  File: /tmp/artifacts/junit_05.xml
  Size: 186201    	Blocks: 368        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 274376      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-12-03 22:00:50.798485260 +0000
Modify: 2021-12-03 22:00:50.802485217 +0000
Change: 2021-12-03 22:00:50.802485217 +0000
 Birth: 2021-12-03 22:00:50.798485260 +0000
  File: /tmp/artifacts/junit_06.xml
  Size: 409804    	Blocks: 808        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 274375      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-12-03 22:00:47.476521150 +0000
Modify: 2021-12-03 22:00:47.483521074 +0000
Change: 2021-12-03 22:00:47.483521074 +0000
 Birth: 2021-12-03 22:00:47.476521150 +0000
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX '/tmp/artifacts/*'
+ scp -r -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config 'openshiftdevel:/tmp/artifacts/*' /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kubelet.log
  File: /tmp/kubelet.log
  Size: 1007331   	Blocks: 1968       IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 1230        Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: system_u:object_r:tmp_t:s0
Access: 2021-12-03 21:59:18.175486228 +0000
Modify: 2021-12-03 22:02:00.425733058 +0000
Change: 2021-12-03 22:02:00.425733058 +0000
 Birth: 2021-12-03 21:59:18.175486228 +0000
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /tmp/kubelet.log
+ scp -r -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/tmp/kubelet.log /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-apiserver.log
  File: /tmp/kube-apiserver.log
  Size: 2674241   	Blocks: 5224       IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 1224        Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: system_u:object_r:tmp_t:s0
Access: 2021-12-03 21:59:09.102584328 +0000
Modify: 2021-12-03 22:01:57.660762930 +0000
Change: 2021-12-03 22:01:57.660762930 +0000
 Birth: 2021-12-03 21:59:09.102584328 +0000
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /tmp/kube-apiserver.log
+ scp -r -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/tmp/kube-apiserver.log /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-controller-manager.log
  File: /tmp/kube-controller-manager.log
  Size: 91052     	Blocks: 184        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 1227        Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: system_u:object_r:tmp_t:s0
Access: 2021-12-03 21:59:13.812533402 +0000
Modify: 2021-12-03 22:01:48.064866598 +0000
Change: 2021-12-03 22:01:48.064866598 +0000
 Birth: 2021-12-03 21:59:13.812533402 +0000
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /tmp/kube-controller-manager.log
+ scp -r -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/tmp/kube-controller-manager.log /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-proxy.log
  File: /tmp/kube-proxy.log
  Size: 16392     	Blocks: 40         IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 1232        Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: system_u:object_r:tmp_t:s0
Access: 2021-12-03 21:59:25.274409473 +0000
Modify: 2021-12-03 21:59:53.394105429 +0000
Change: 2021-12-03 21:59:53.394105429 +0000
 Birth: 2021-12-03 21:59:25.274409473 +0000
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /tmp/kube-proxy.log
+ scp -r -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/tmp/kube-proxy.log /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-proxy.yaml
  File: /tmp/kube-proxy.yaml
  Size: 509       	Blocks: 8          IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 1233        Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: system_u:object_r:tmp_t:s0
Access: 2021-12-03 21:59:25.429407797 +0000
Modify: 2021-12-03 21:59:24.905413463 +0000
Change: 2021-12-03 21:59:24.905413463 +0000
 Birth: 2021-12-03 21:59:24.899413528 +0000
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /tmp/kube-proxy.yaml
+ scp -r -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/tmp/kube-proxy.yaml /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-scheduler.log
  File: /tmp/kube-scheduler.log
  Size: 86383     	Blocks: 184        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 1228        Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: system_u:object_r:tmp_t:s0
Access: 2021-12-03 21:59:13.814533380 +0000
Modify: 2021-12-03 22:01:36.979986348 +0000
Change: 2021-12-03 22:01:36.979986348 +0000
 Birth: 2021-12-03 21:59:13.814533380 +0000
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /tmp/kube-scheduler.log
+ scp -r -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/tmp/kube-scheduler.log /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /etc/crio/crio.conf
  File: /etc/crio/crio.conf
  Size: 174       	Blocks: 8          IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 1065353     Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:container_config_t:s0
Access: 2021-12-03 21:58:20.493109917 +0000
Modify: 2021-12-03 21:58:18.554130882 +0000
Change: 2021-12-03 21:58:18.554130882 +0000
 Birth: 2021-12-03 21:58:18.554130882 +0000
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /etc/crio/crio.conf
+ scp -r -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/etc/crio/crio.conf /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered
+ tree /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered
/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered
├── crio.conf
├── e2e.log
├── junit_01.xml
├── junit_02.xml
├── junit_03.xml
├── junit_04.xml
├── junit_05.xml
├── junit_06.xml
├── kube-apiserver.log
├── kube-controller-manager.log
├── kubelet.log
├── kube-proxy.log
├── kube-proxy.yaml
└── kube-scheduler.log

0 directories, 14 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins1471423065480082028.sh
########## STARTING STAGE: GENERATE ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/generated
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/generated
+ mkdir /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/generated
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo pvs && sudo vgs && sudo lvs 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo yum list installed 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo ausearch -m AVC -m SELINUX_ERR -m USER_AVC 2>&1'
+ true
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo journalctl --no-pager --boot 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo journalctl _PID=1 --no-pager --all --lines=all 2>&1'
+ tree /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/generated
/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/generated
├── avc_denials.log
├── filesystem.info
├── installed_packages.log
├── pid1.journal
└── system.journal

0 directories, 5 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins5723545886458719268.sh
########## STARTING STAGE: FETCH SYSTEMD JOURNALS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/journals
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/journals
+ mkdir /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/journals
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit crio.service --no-pager --all --lines=all
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit customcluster.service --no-pager --all --lines=all
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit systemd-journald.service --no-pager --all --lines=all
+ tree /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/journals
/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/journals
├── crio.service
├── customcluster.service
└── systemd-journald.service

0 directories, 3 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins7112604723448136895.sh
########## STARTING STAGE: CREATE /DATA, INSTALL JQ, DOCKER, AND START DOCKERD ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
++ mktemp
+ script=/tmp/tmp.AJGEBjRION
+ cat
+ chmod +x /tmp/tmp.AJGEBjRION
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.AJGEBjRION openshiftdevel:/tmp/tmp.AJGEBjRION
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.AJGEBjRION"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ sudo mkdir -p /data/gcs
+ sudo chown -R origin:origin /data
+ grep -q 'ID="centos"' /etc/os-release
+ grep -q 'ID="rhel"' /etc/os-release
+ sudo dnf install -y jq podman-docker
Last metadata expiration check: 0:14:44 ago on Fri 03 Dec 2021 09:47:33 PM UTC.
Dependencies resolved.
================================================================================
 Package                   Arch   Version                         Repo     Size
================================================================================
Installing:
 jq                        x86_64 1.6-2.fc30                      fedora  168 k
 podman-docker             noarch 2:1.8.0-4.fc30                  updates  71 k
Installing dependencies:
 conmon                    x86_64 2:2.0.13-1.fc30                 updates  38 k
 containernetworking-plugins
                           x86_64 0.8.5-1.fc30                    updates  20 M
 fuse3                     x86_64 3.6.2-1.fc30                    updates  53 k
 fuse3-libs                x86_64 3.6.2-1.fc30                    updates  88 k
 libbsd                    x86_64 0.9.1-3.fc30                    fedora  100 k
 libnet                    x86_64 1.1.6-17.fc30                   fedora   61 k
 libnftnl                  x86_64 1.1.3-1.fc30                    updates  71 k
 nftables                  x86_64 1:0.9.1-2.fc30                  updates 289 k
 oniguruma                 x86_64 6.9.2-4.fc30                    updates 198 k
 podman                    x86_64 2:1.8.0-4.fc30                  updates  13 M
 podman-plugins            x86_64 2:1.8.0-4.fc30                  updates 1.3 M
 protobuf-c                x86_64 1.3.1-2.fc30                    fedora   33 k
Installing weak dependencies:
 criu                      x86_64 3.13-5.fc30                     updates 482 k
 fuse-overlayfs            x86_64 0.7.5-2.fc30                    updates  62 k
 libvarlink-util           x86_64 18-1.fc30                       updates  47 k
 runc                      x86_64 2:1.0.0-102.dev.gitdc9208a.fc30 updates 2.7 M
 slirp4netns               x86_64 0.4.0-4.git19d199a.fc30         updates  85 k

Transaction Summary
================================================================================
Install  19 Packages

Total download size: 39 M
Installed size: 150 M
Downloading Packages:
(1/19): conmon-2.0.13-1.fc30.x86_64.rpm         1.1 MB/s |  38 kB     00:00    
(2/19): fuse-overlayfs-0.7.5-2.fc30.x86_64.rpm  7.1 MB/s |  62 kB     00:00    
(3/19): fuse3-3.6.2-1.fc30.x86_64.rpm           8.7 MB/s |  53 kB     00:00    
(4/19): fuse3-libs-3.6.2-1.fc30.x86_64.rpm       13 MB/s |  88 kB     00:00    
(5/19): criu-3.13-5.fc30.x86_64.rpm             6.9 MB/s | 482 kB     00:00    
(6/19): libnftnl-1.1.3-1.fc30.x86_64.rpm        2.8 MB/s |  71 kB     00:00    
(7/19): libvarlink-util-18-1.fc30.x86_64.rpm    3.0 MB/s |  47 kB     00:00    
(8/19): oniguruma-6.9.2-4.fc30.x86_64.rpm       6.9 MB/s | 198 kB     00:00    
(9/19): nftables-0.9.1-2.fc30.x86_64.rpm        2.2 MB/s | 289 kB     00:00    
(10/19): podman-docker-1.8.0-4.fc30.noarch.rpm  1.1 MB/s |  71 kB     00:00    
(11/19): containernetworking-plugins-0.8.5-1.fc  35 MB/s |  20 MB     00:00    
(12/19): podman-plugins-1.8.0-4.fc30.x86_64.rpm 4.4 MB/s | 1.3 MB     00:00    
(13/19): slirp4netns-0.4.0-4.git19d199a.fc30.x8 1.1 MB/s |  85 kB     00:00    
(14/19): podman-1.8.0-4.fc30.x86_64.rpm          21 MB/s |  13 MB     00:00    
(15/19): jq-1.6-2.fc30.x86_64.rpm               1.7 MB/s | 168 kB     00:00    
(16/19): runc-1.0.0-102.dev.gitdc9208a.fc30.x86  13 MB/s | 2.7 MB     00:00    
(17/19): libbsd-0.9.1-3.fc30.x86_64.rpm         6.1 MB/s | 100 kB     00:00    
(18/19): protobuf-c-1.3.1-2.fc30.x86_64.rpm     6.5 MB/s |  33 kB     00:00    
(19/19): libnet-1.1.6-17.fc30.x86_64.rpm        2.5 MB/s |  61 kB     00:00    
--------------------------------------------------------------------------------
Total                                            42 MB/s |  39 MB     00:00     
Running transaction check
Transaction check succeeded.
Running transaction test
Transaction test succeeded.
Running transaction
  Preparing        :                                                        1/1 
  Installing       : fuse3-libs-3.6.2-1.fc30.x86_64                        1/19 
  Installing       : fuse3-3.6.2-1.fc30.x86_64                             2/19 
  Installing       : fuse-overlayfs-0.7.5-2.fc30.x86_64                    3/19 
  Running scriptlet: fuse-overlayfs-0.7.5-2.fc30.x86_64                    3/19 
  Installing       : protobuf-c-1.3.1-2.fc30.x86_64                        4/19 
  Installing       : libnet-1.1.6-17.fc30.x86_64                           5/19 
  Installing       : libbsd-0.9.1-3.fc30.x86_64                            6/19 
  Installing       : criu-3.13-5.fc30.x86_64                               7/19 
  Installing       : runc-2:1.0.0-102.dev.gitdc9208a.fc30.x86_64           8/19 
  Installing       : slirp4netns-0.4.0-4.git19d199a.fc30.x86_64            9/19 
  Installing       : podman-plugins-2:1.8.0-4.fc30.x86_64                 10/19 
  Installing       : oniguruma-6.9.2-4.fc30.x86_64                        11/19 
  Installing       : libvarlink-util-18-1.fc30.x86_64                     12/19 
  Installing       : libnftnl-1.1.3-1.fc30.x86_64                         13/19 
  Installing       : nftables-1:0.9.1-2.fc30.x86_64                       14/19 
  Running scriptlet: nftables-1:0.9.1-2.fc30.x86_64                       14/19 
  Installing       : containernetworking-plugins-0.8.5-1.fc30.x86_64      15/19 
  Installing       : conmon-2:2.0.13-1.fc30.x86_64                        16/19 
  Installing       : podman-2:1.8.0-4.fc30.x86_64                         17/19 
  Installing       : podman-docker-2:1.8.0-4.fc30.noarch                  18/19 
  Installing       : jq-1.6-2.fc30.x86_64                                 19/19 
  Running scriptlet: jq-1.6-2.fc30.x86_64                                 19/19 
  Verifying        : conmon-2:2.0.13-1.fc30.x86_64                         1/19 
  Verifying        : containernetworking-plugins-0.8.5-1.fc30.x86_64       2/19 
  Verifying        : criu-3.13-5.fc30.x86_64                               3/19 
  Verifying        : fuse-overlayfs-0.7.5-2.fc30.x86_64                    4/19 
  Verifying        : fuse3-3.6.2-1.fc30.x86_64                             5/19 
  Verifying        : fuse3-libs-3.6.2-1.fc30.x86_64                        6/19 
  Verifying        : libnftnl-1.1.3-1.fc30.x86_64                          7/19 
  Verifying        : libvarlink-util-18-1.fc30.x86_64                      8/19 
  Verifying        : nftables-1:0.9.1-2.fc30.x86_64                        9/19 
  Verifying        : oniguruma-6.9.2-4.fc30.x86_64                        10/19 
  Verifying        : podman-2:1.8.0-4.fc30.x86_64                         11/19 
  Verifying        : podman-docker-2:1.8.0-4.fc30.noarch                  12/19 
  Verifying        : podman-plugins-2:1.8.0-4.fc30.x86_64                 13/19 
  Verifying        : runc-2:1.0.0-102.dev.gitdc9208a.fc30.x86_64          14/19 
  Verifying        : slirp4netns-0.4.0-4.git19d199a.fc30.x86_64           15/19 
  Verifying        : jq-1.6-2.fc30.x86_64                                 16/19 
  Verifying        : libbsd-0.9.1-3.fc30.x86_64                           17/19 
  Verifying        : libnet-1.1.6-17.fc30.x86_64                          18/19 
  Verifying        : protobuf-c-1.3.1-2.fc30.x86_64                       19/19 

Installed:
  conmon-2:2.0.13-1.fc30.x86_64                                                 
  containernetworking-plugins-0.8.5-1.fc30.x86_64                               
  criu-3.13-5.fc30.x86_64                                                       
  fuse-overlayfs-0.7.5-2.fc30.x86_64                                            
  fuse3-3.6.2-1.fc30.x86_64                                                     
  fuse3-libs-3.6.2-1.fc30.x86_64                                                
  jq-1.6-2.fc30.x86_64                                                          
  libbsd-0.9.1-3.fc30.x86_64                                                    
  libnet-1.1.6-17.fc30.x86_64                                                   
  libnftnl-1.1.3-1.fc30.x86_64                                                  
  libvarlink-util-18-1.fc30.x86_64                                              
  nftables-1:0.9.1-2.fc30.x86_64                                                
  oniguruma-6.9.2-4.fc30.x86_64                                                 
  podman-2:1.8.0-4.fc30.x86_64                                                  
  podman-docker-2:1.8.0-4.fc30.noarch                                           
  podman-plugins-2:1.8.0-4.fc30.x86_64                                          
  protobuf-c-1.3.1-2.fc30.x86_64                                                
  runc-2:1.0.0-102.dev.gitdc9208a.fc30.x86_64                                   
  slirp4netns-0.4.0-4.git19d199a.fc30.x86_64                                    

Complete!
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: CREATE /DATA, INSTALL JQ, DOCKER, AND START DOCKERD [00h 00m 15s] ##########
[workspace] $ /bin/bash /tmp/jenkins6209561912656538214.sh
########## STARTING STAGE: ASSEMBLE GCS OUTPUT ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
+ trap 'exit 0' EXIT
+ mkdir -p gcs/artifacts gcs/artifacts/generated gcs/artifacts/journals gcs/artifacts/gathered
++ python -c 'import json; import urllib; print json.load(urllib.urlopen('\''https://ci.openshift.redhat.com/jenkins/job/test_pull_request_crio_e2e_features_fedora/22918/api/json'\''))['\''result'\'']'
+ result=SUCCESS
+ cat
++ date +%s
+ cat /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/builds/22918/log
+ cp -r artifacts/gathered/crio.conf artifacts/gathered/e2e.log artifacts/gathered/junit_01.xml artifacts/gathered/junit_02.xml artifacts/gathered/junit_03.xml artifacts/gathered/junit_04.xml artifacts/gathered/junit_05.xml artifacts/gathered/junit_06.xml artifacts/gathered/kube-apiserver.log artifacts/gathered/kube-controller-manager.log artifacts/gathered/kubelet.log artifacts/gathered/kube-proxy.log artifacts/gathered/kube-proxy.yaml artifacts/gathered/kube-scheduler.log gcs/artifacts/
+ cp artifacts/generated/avc_denials.log artifacts/generated/filesystem.info artifacts/generated/installed_packages.log artifacts/generated/pid1.journal artifacts/generated/system.journal gcs/artifacts/generated/
+ cp artifacts/journals/crio.service artifacts/journals/customcluster.service artifacts/journals/systemd-journald.service gcs/artifacts/journals/
++ pwd
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config -r /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/gcs openshiftdevel:/data
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config /var/lib/jenkins/.config/gcloud/gcs-publisher-credentials.json openshiftdevel:/data/credentials.json
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins1958830017488129329.sh
########## STARTING STAGE: PUSH THE ARTIFACTS AND METADATA ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
++ mktemp
+ script=/tmp/tmp.a8ZyFQrVN8
+ cat
+ chmod +x /tmp/tmp.a8ZyFQrVN8
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.a8ZyFQrVN8 openshiftdevel:/tmp/tmp.a8ZyFQrVN8
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.a8ZyFQrVN8"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ [[ -n {"type":"presubmit","job":"test_pull_request_crio_e2e_features_fedora","buildid":"1466883820778164228","prowjobid":"e10157f5-5480-11ec-a043-0a580a80114f","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"367232bb1bc7ab3a3bd5a863daf701b036966473","base_link":"https://github.com/cri-o/cri-o/commit/367232bb1bc7ab3a3bd5a863daf701b036966473","pulls":[{"number":5481,"author":"haircommander","sha":"cdea325eebf5dbe3cab767d32253aa0c39b1eeaa","title":"Allow swap to be configured if lower than memory on cgroupv2","link":"https://github.com/cri-o/cri-o/pull/5481","commit_link":"https://github.com/cri-o/cri-o/pull/5481/commits/cdea325eebf5dbe3cab767d32253aa0c39b1eeaa","author_link":"https://github.com/haircommander"}]}} ]]
++ jq --compact-output '.buildid |= "22918"'
+ JOB_SPEC='{"type":"presubmit","job":"test_pull_request_crio_e2e_features_fedora","buildid":"22918","prowjobid":"e10157f5-5480-11ec-a043-0a580a80114f","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"367232bb1bc7ab3a3bd5a863daf701b036966473","base_link":"https://github.com/cri-o/cri-o/commit/367232bb1bc7ab3a3bd5a863daf701b036966473","pulls":[{"number":5481,"author":"haircommander","sha":"cdea325eebf5dbe3cab767d32253aa0c39b1eeaa","title":"Allow swap to be configured if lower than memory on cgroupv2","link":"https://github.com/cri-o/cri-o/pull/5481","commit_link":"https://github.com/cri-o/cri-o/pull/5481/commits/cdea325eebf5dbe3cab767d32253aa0c39b1eeaa","author_link":"https://github.com/haircommander"}]}}'
+ sudo docker run -e 'JOB_SPEC={"type":"presubmit","job":"test_pull_request_crio_e2e_features_fedora","buildid":"22918","prowjobid":"e10157f5-5480-11ec-a043-0a580a80114f","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"367232bb1bc7ab3a3bd5a863daf701b036966473","base_link":"https://github.com/cri-o/cri-o/commit/367232bb1bc7ab3a3bd5a863daf701b036966473","pulls":[{"number":5481,"author":"haircommander","sha":"cdea325eebf5dbe3cab767d32253aa0c39b1eeaa","title":"Allow swap to be configured if lower than memory on cgroupv2","link":"https://github.com/cri-o/cri-o/pull/5481","commit_link":"https://github.com/cri-o/cri-o/pull/5481/commits/cdea325eebf5dbe3cab767d32253aa0c39b1eeaa","author_link":"https://github.com/haircommander"}]}}' -v /data:/data:z registry.ci.openshift.org/ci/gcsupload:latest --dry-run=false --gcs-path=gs://origin-federated-results --gcs-credentials-file=/data/credentials.json /data/gcs/artifacts /data/gcs/build-log.txt /data/gcs/finished.json /data/gcs/started.json
Emulate Docker CLI using podman. Create /etc/containers/nodocker to quiet msg.
Trying to pull registry.ci.openshift.org/ci/gcsupload:latest...
Getting image source signatures
Copying blob sha256:85cea451eec057fa7e734548ca3ba6d779ed5836a3f9de14b8394575ef0d7d8e
Copying blob sha256:0fc60639ab8d8aaa6b091729e4f59c5eec06fcb150f3ca2b3a7a8a0e8102e6d0
Copying blob sha256:df20fa9351a15782c64e6dddb2d4a6f50bf6d3688060a34c4014b0d9a752eb4c
Copying blob sha256:809b39f1848ee7cb2dbba3bff7065c1997cd5b19424d2e33ce139262d43a8887
Copying config sha256:a2ef94555c8b179b2f50ce718f2d8b476146c82ffb65bd749ae7e8eddb33d6d6
Writing manifest to image destination
Storing signatures
{"component":"gcsupload","file":"prow/gcsupload/run.go:194","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts","level":"info","msg":"Gathering artifacts from artifact directory: /data/gcs/artifacts","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/crio.conf in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/crio.conf\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/e2e.log in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/e2e.log\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/avc_denials.log in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/avc_denials.log\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/filesystem.info in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/filesystem.info\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/installed_packages.log in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/installed_packages.log\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/pid1.journal in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/pid1.journal\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/system.journal in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/system.journal\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/journals/crio.service in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/journals/crio.service\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/journals/customcluster.service in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/journals/customcluster.service\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/journals/systemd-journald.service in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/journals/systemd-journald.service\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/junit_01.xml in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_01.xml\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/junit_02.xml in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_02.xml\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/junit_03.xml in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_03.xml\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/junit_04.xml in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_04.xml\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/junit_05.xml in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_05.xml\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/junit_06.xml in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_06.xml\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/kube-apiserver.log in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-apiserver.log\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/kube-controller-manager.log in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-controller-manager.log\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/kube-proxy.log in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-proxy.log\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/kube-proxy.yaml in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-proxy.yaml\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/kube-scheduler.log in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-scheduler.log\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/kubelet.log in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kubelet.log\n","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-scheduler.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/filesystem.info","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_02.xml","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_04.xml","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_06.xml","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/build-log.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/finished.json","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/started.json","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/avc_denials.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/journals/systemd-journald.service","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-proxy.yaml","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_03.xml","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_e2e_features_fedora/22918.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/e2e.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/installed_packages.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/pid1.journal","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_05.xml","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kubelet.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-proxy.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/system.journal","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-apiserver.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/journals/customcluster.service","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-controller-manager.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_e2e_features_fedora/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/crio.conf","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/journals/crio.service","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_01.xml","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-03T22:02:34Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/filesystem.info","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-scheduler.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_02.xml","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_04.xml","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_06.xml","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/build-log.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/finished.json","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/avc_denials.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/journals/systemd-journald.service","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-proxy.yaml","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/started.json","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_03.xml","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/e2e.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_e2e_features_fedora/22918.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/installed_packages.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/pid1.journal","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_05.xml","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:35Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kubelet.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:36Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-proxy.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:36Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/journals/customcluster.service","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:36Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/generated/system.journal","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:36Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-controller-manager.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:36Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/kube-apiserver.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:36Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/crio.conf","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:36Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/junit_01.xml","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:36Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5481/test_pull_request_crio_e2e_features_fedora/22918/artifacts/journals/crio.service","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:36Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_e2e_features_fedora/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-03T22:02:36Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:78","func":"k8s.io/test-infra/prow/gcsupload.completeUpload","level":"info","msg":"Finished upload to blob storage","severity":"info","time":"2021-12-03T22:02:36Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:78","func":"k8s.io/test-infra/prow/gcsupload.completeUpload","level":"info","msg":"Finished upload to blob storage","severity":"info","time":"2021-12-03T22:02:36Z"}
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 06s] ##########
[workspace] $ /bin/bash /tmp/jenkins4844288312910318538.sh
########## STARTING STAGE: DEPROVISION CLOUD RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d
++ export PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config
+ oct deprovision

PLAYBOOK: main.yml *************************************************************
4 plays in /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml

PLAY [ensure we have the parameters necessary to deprovision virtual hosts] ****

TASK [ensure all required variables are set] ***********************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:9
skipping: [localhost] => (item=origin_ci_inventory_dir)  => {
    "changed": false, 
    "generated_timestamp": "2021-12-03 17:02:37.731933", 
    "item": "origin_ci_inventory_dir", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_region)  => {
    "changed": false, 
    "generated_timestamp": "2021-12-03 17:02:37.736633", 
    "item": "origin_ci_aws_region", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}

PLAY [deprovision virtual hosts in EC2] ****************************************

TASK [Gathering Facts] *********************************************************
ok: [localhost]

TASK [deprovision a virtual EC2 host] ******************************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:28
included: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml for localhost

TASK [update the SSH configuration to remove AWS EC2 specifics] ****************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:2
ok: [localhost] => {
    "changed": false, 
    "generated_timestamp": "2021-12-03 17:02:38.632710", 
    "msg": ""
}

TASK [rename EC2 instance for termination reaper] ******************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:8
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2021-12-03 17:02:39.333727", 
    "msg": "Tags {'Name': 'oct-terminate'} created for resource i-03947c030031e31fe."
}

TASK [tear down the EC2 instance] **********************************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:15
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2021-12-03 17:02:40.600866", 
    "instance_ids": [
        "i-03947c030031e31fe"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-05f134415da520cbf"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-070b074a7092a3026"
                }
            }, 
            "dns_name": "ec2-54-80-65-128.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-03947c030031e31fe", 
            "image_id": "ami-038b90348c4438d19", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "openshift-dev", 
            "launch_time": "2021-12-03T21:36:19.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-4-214.ec2.internal", 
            "private_ip": "172.18.4.214", 
            "public_dns_name": "ec2-54-80-65-128.compute-1.amazonaws.com", 
            "public_ip": "54.80.65.128", 
            "ramdisk": null, 
            "region": "us-east-1", 
            "root_device_name": "/dev/sda1", 
            "root_device_type": "ebs", 
            "state": "running", 
            "state_code": 16, 
            "tags": {
                "Name": "oct-terminate", 
                "openshift_etcd": "", 
                "openshift_master": "", 
                "openshift_node": ""
            }, 
            "tenancy": "default", 
            "virtualization_type": "hvm"
        }
    ], 
    "tagged_instances": []
}

TASK [remove the serialized host variables] ************************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:22
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2021-12-03 17:02:40.880118", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.4.214.yml", 
    "state": "absent"
}

PLAY [deprovision virtual hosts locally manged by Vagrant] *********************

TASK [Gathering Facts] *********************************************************
ok: [localhost]

PLAY [clean up local configuration for deprovisioned instances] ****************

TASK [remove inventory configuration directory] ********************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:61
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2021-12-03 17:02:41.429652", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory", 
    "state": "absent"
}

PLAY RECAP *********************************************************************
localhost                  : ok=8    changed=4    unreachable=0    failed=0   

+ set +o xtrace
########## FINISHED STAGE: SUCCESS: DEPROVISION CLOUD RESOURCES [00h 00m 05s] ##########
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
sent [/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered/e2e.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered/kube-apiserver.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered/kube-controller-manager.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered/kube-proxy.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered/kube-scheduler.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/gathered/kubelet.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/generated/avc_denials.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/artifacts/generated/installed_packages.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/gcs/artifacts/e2e.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/gcs/artifacts/generated/avc_denials.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/gcs/artifacts/generated/installed_packages.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/gcs/artifacts/kube-apiserver.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/gcs/artifacts/kube-controller-manager.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/gcs/artifacts/kube-proxy.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/gcs/artifacts/kube-scheduler.log, /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/gcs/artifacts/kubelet.log] to splunk in 42 events
[WS-CLEANUP] Deleting project workspace...
[WS-CLEANUP] Deferred wipeout is used...
[WS-CLEANUP] done
Finished: SUCCESS