SuccessConsole 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": 1632862994.5663257, "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": 1632862994.5663257, "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-09-28T21:06:28Z\" 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-09-28 21:06:28.571967563Z\" level=info msg=\"Starting CRI-O, version: 1.22.0, git: 7276a63645011d51976f1546db74c2ea592e6f08(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-09-28T21:06:28Z\" 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-09-28 21:06:28.571967563Z\" level=info msg=\"Starting CRI-O, version: 1.22.0, git: 7276a63645011d51976f1546db74c2ea592e6f08(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-09-28T21:04:05Z' -X github.com/cri-o/cri-o/internal/version.gitCommit=7276a63645011d51976f1546db74c2ea592e6f08 -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-09-28T21:06:22Z' -X github.com/cri-o/cri-o/internal/version.gitCommit=7276a63645011d51976f1546db74c2ea592e6f08 -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-09-28T21:04:05Z' -X github.com/cri-o/cri-o/internal/version.gitCommit=7276a63645011d51976f1546db74c2ea592e6f08 -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-09-28T21:06:22Z' -X github.com/cri-o/cri-o/internal/version.gitCommit=7276a63645011d51976f1546db74c2ea592e6f08 -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-1632863198.8875766-10991-38149434368035/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-1632863200.1158621-11078-174557888839615/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-1632863200.4834797-11106-197614151291985/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, "dest": "/usr/bin/jq", "elapsed": 0, "gid": 0, "group": "root", "mode": "0775", "msg": "HTTP Error 304: Not Modified", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 3953824, "state": "file", "status_code": 304, "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": "d1c9b43e94b49d77cede5af42ef802961584b5bc", "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-298-gd1c9b43e -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-298-gd1c9b43e -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

TASK [All active swap devices are known] ***************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/disable_swap.yml:2
ok: [localhost] => {"changed": false, "cmd": ["swapon", "--show", "--ifexists", "--noheadings"], "delta": "0:00:00.005266", "end": "2021-09-28 21:07:13.765278", "rc": 0, "start": "2021-09-28 21:07:13.760012", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}

TASK [All active swap is disabled] *********************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/disable_swap.yml:7
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [All persistent swap devices from fstab are known] ************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/disable_swap.yml:11
ok: [localhost] => {"changed": false, "cmd": ["findmnt", "--fstab", "--type", "swap", "--output", "SOURCE", "--noheadings"], "delta": "0:00:00.004295", "end": "2021-09-28 21:07:13.991406", "failed_when_result": false, "msg": "non-zero return code", "rc": 1, "start": "2021-09-28 21:07:13.987111", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}

TASK [Swap configuration does not persist across future reboots] ***************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/disable_swap.yml:18
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:170
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": "87249670ec5386e8263e7893ad424da6419a6f7e", "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.203672", "end": "2021-09-28 21:08:17.433597", "rc": 0, "start": "2021-09-28 21:08:17.229925", "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": "+++ [0928 21:08:17] Verifying Prerequisites....\n+++ [0928 21:08:18] Removing _output directory\nRemoving test/e2e/generated/bindata.go ..", "stdout_lines": ["+++ [0928 21:08:17] Verifying Prerequisites....", "+++ [0928 21:08:18] 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": "+++ [0928 21:08:49] Building go targets for linux/amd64:\n    ./vendor/k8s.io/code-generator/cmd/prerelease-lifecycle-gen\nGenerating prerelease lifecycle code for 27 targets\n+++ [0928 21:08:53] Building go targets for linux/amd64:\n    ./vendor/k8s.io/code-generator/cmd/deepcopy-gen\nGenerating deepcopy code for 227 targets\n+++ [0928 21:09:02] Building go targets for linux/amd64:\n    ./vendor/k8s.io/code-generator/cmd/defaulter-gen\nGenerating defaulter code for 89 targets\n+++ [0928 21:09:13] Building go targets for linux/amd64:\n    ./vendor/k8s.io/code-generator/cmd/conversion-gen\nGenerating conversion code for 124 targets\n+++ [0928 21:09:34] 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+++ [0928 21:09:50] Building go targets for linux/amd64:\n    ./vendor/github.com/go-bindata/go-bindata/go-bindata\n+++ [0928 21:09:53] 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": ["+++ [0928 21:08:49] Building go targets for linux/amd64:", "    ./vendor/k8s.io/code-generator/cmd/prerelease-lifecycle-gen", "Generating prerelease lifecycle code for 27 targets", "+++ [0928 21:08:53] Building go targets for linux/amd64:", "    ./vendor/k8s.io/code-generator/cmd/deepcopy-gen", "Generating deepcopy code for 227 targets", "+++ [0928 21:09:02] Building go targets for linux/amd64:", "    ./vendor/k8s.io/code-generator/cmd/defaulter-gen", "Generating defaulter code for 89 targets", "+++ [0928 21:09:13] Building go targets for linux/amd64:", "    ./vendor/k8s.io/code-generator/cmd/conversion-gen", "Generating conversion code for 124 targets", "+++ [0928 21:09:34] 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", "+++ [0928 21:09:50] Building go targets for linux/amd64:", "    ./vendor/github.com/go-bindata/go-bindata/go-bindata", "+++ [0928 21:09:53] 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": "98307adf6a62d2ce38b24bf29859842d109d31bc", "dest": "/usr/local/bin/createcluster.sh", "gid": 0, "group": "root", "md5sum": "55866883e8fb6b36e857494ee9ad2a6e", "mode": "0771", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 1054, "src": "/home/origin/.ansible/tmp/ansible-tmp-1632864125.1079447-27265-160047823189950/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": "84d81706efb6b2e78b75a457a318e811e781c911", "dest": "/go/bin/kubectl", "gid": 0, "group": "root", "md5sum": "f629edc8f670767d4395e6c1510f84d7", "mode": "0755", "owner": "root", "secontext": "system_u:object_r:default_t:s0", "size": 44802048, "src": "/home/origin/.ansible/tmp/ansible-tmp-1632864125.9201803-27333-257514012109161/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": "c5228702a9124652b6e05e73b1f72854198dbb01", "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.941325", "end": "2021-09-28 21:23:41.993391", "rc": 0, "start": "2021-09-28 21:22:27.052066", "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.311589", "end": "2021-09-28 21:23:42.906897", "rc": 0, "start": "2021-09-28 21:23:42.595308", "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 AAAAB3NzaC1yc2EAAAADAQABAAABAQCrmDLtH8P7iWJEtP45rgzy8xKCUX0TQc4GfL4DerwNb3zJigE+ZaJNQDCQEXhBVJp2D46S4H7UOqIwKUzAz4PCfKc8cAJ+nH6m6LUPYPy/a7klMyT+1H1S3CoFnWnutpGb/pCOtMO7lXjWaNu7MZmJ630OLVAsL5ffTlng10hXOQIYAWDncPjH2PcwDdF4lwa5DauYhcWi+LdOGzyLZxKLxvrVONiLfoanQ1EvY6ORMMjxtsyxYsREvuz4N5N/wxtKHEhfT17gzIBXTOrjy9BX2ouRFaQZUf3ore/9uO/CYfTzA9BSihFSU1pPa1gdSYS1Y0PG8yeDENJZ5saWbhYT root@ip-172-18-6-79.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": "system.slice network-online.target systemd-journald.socket sysinit.target basic.target", "AllowIsolate": "no", "AmbientCapabilities": "", "AssertResult": "no", "AssertTimestampMonotonic": "0", "Before": "shutdown.target kubelet.service", "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": "sysinit.target system.slice", "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": "-.mount sysinit.target network-online.target systemd-journald.socket basic.target 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": "system.slice sysinit.target -.mount", "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.103659", "end": "2021-09-28 21:25:20.211772", "rc": 0, "start": "2021-09-28 21:25:20.108113", "stderr": "", "stderr_lines": [], "stdout": "172.18.6.79:MemoryPressure=False;DiskPressure=False;PIDPressure=False;Ready=True;", "stdout_lines": ["172.18.6.79: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.019334", "end": "2021-09-28 21:25:20.834935", "rc": 0, "start": "2021-09-28 21:25:20.815601", "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.6.79: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.005096", "end": "2021-09-28 21:25:21.578465", "rc": 0, "start": "2021-09-28 21:25:21.573369", "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": "98168463412.2688", "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.6.79: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:00.931171", "end": "2021-09-28 21:26:23.210286", "finished": 1, "rc": 0, "start": "2021-09-28 21:25:22.279115", "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.009347", "end": "2021-09-28 21:27:23.204565", "rc": 0, "start": "2021-09-28 21:27:23.195218", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}
META: ran handlers
META: ran handlers

PLAY RECAP *********************************************************************
localhost                  : ok=56   changed=44   unreachable=0    failed=0    skipped=50   rescued=0    ignored=0   

+ set +o xtrace
########## FINISHED STAGE: SUCCESS: RUN THE CRI-O E2E FEATURES TESTS [00h 24m 09s] ##########
[PostBuildScript] - [INFO] Executing post build scripts.
[workspace] $ /bin/bash /tmp/jenkins2305832536655653496.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: 163468    	Blocks: 328        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 275233      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-09-28 21:25:22.281203085 +0000
Modify: 2021-09-28 21:26:23.207116081 +0000
Change: 2021-09-28 21:26:23.207116081 +0000
 Birth: 2021-09-28 21:25:22.281203085 +0000
  File: /tmp/artifacts/junit_01.xml
  Size: 288297    	Blocks: 568        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 275237      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-09-28 21:26:23.189116107 +0000
Modify: 2021-09-28 21:26:23.194116100 +0000
Change: 2021-09-28 21:26:23.194116100 +0000
 Birth: 2021-09-28 21:26:23.189116107 +0000
  File: /tmp/artifacts/junit_02.xml
  Size: 432427    	Blocks: 848        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 275229      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-09-28 21:26:19.906120795 +0000
Modify: 2021-09-28 21:26:19.913120785 +0000
Change: 2021-09-28 21:26:19.913120785 +0000
 Birth: 2021-09-28 21:26:19.906120795 +0000
  File: /tmp/artifacts/junit_03.xml
  Size: 289727    	Blocks: 568        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 275235      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-09-28 21:26:21.494118528 +0000
Modify: 2021-09-28 21:26:21.498118522 +0000
Change: 2021-09-28 21:26:21.498118522 +0000
 Birth: 2021-09-28 21:26:21.494118528 +0000
  File: /tmp/artifacts/junit_04.xml
  Size: 182951    	Blocks: 360        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 275236      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-09-28 21:26:23.153116159 +0000
Modify: 2021-09-28 21:26:23.156116154 +0000
Change: 2021-09-28 21:26:23.156116154 +0000
 Birth: 2021-09-28 21:26:23.153116159 +0000
  File: /tmp/artifacts/junit_05.xml
  Size: 119005    	Blocks: 240        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 275234      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-09-28 21:26:20.542119887 +0000
Modify: 2021-09-28 21:26:20.544119884 +0000
Change: 2021-09-28 21:26:20.544119884 +0000
 Birth: 2021-09-28 21:26:20.542119887 +0000
  File: /tmp/artifacts/junit_06.xml
  Size: 355378    	Blocks: 696        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 275228      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-09-28 21:26:17.592124099 +0000
Modify: 2021-09-28 21:26:17.597124092 +0000
Change: 2021-09-28 21:26:17.597124092 +0000
 Birth: 2021-09-28 21:26:17.592124099 +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: 1147737   	Blocks: 2248       IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 1229        Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: system_u:object_r:tmp_t:s0
Access: 2021-09-28 21:24:44.526140961 +0000
Modify: 2021-09-28 21:27:25.510027115 +0000
Change: 2021-09-28 21:27:25.510027115 +0000
 Birth: 2021-09-28 21:24:44.526140961 +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: 2631463   	Blocks: 5144       IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 1223        Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: system_u:object_r:tmp_t:s0
Access: 2021-09-28 21:24:35.911124843 +0000
Modify: 2021-09-28 21:27:25.324027381 +0000
Change: 2021-09-28 21:27:25.324027381 +0000
 Birth: 2021-09-28 21:24:35.911124843 +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: 93799     	Blocks: 184        IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 1226        Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: system_u:object_r:tmp_t:s0
Access: 2021-09-28 21:24:42.507137184 +0000
Modify: 2021-09-28 21:26:37.505095664 +0000
Change: 2021-09-28 21:26:37.505095664 +0000
 Birth: 2021-09-28 21:24:42.507137184 +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: 16389     	Blocks: 40         IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 1231        Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: system_u:object_r:tmp_t:s0
Access: 2021-09-28 21:24:51.717154412 +0000
Modify: 2021-09-28 21:25:32.421188605 +0000
Change: 2021-09-28 21:25:32.421188605 +0000
 Birth: 2021-09-28 21:24:51.717154412 +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: 508       	Blocks: 8          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-09-28 21:24:51.845154652 +0000
Modify: 2021-09-28 21:24:51.329153686 +0000
Change: 2021-09-28 21:24:51.329153686 +0000
 Birth: 2021-09-28 21:24:51.323153675 +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: 85119     	Blocks: 176        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-09-28 21:24:42.508137185 +0000
Modify: 2021-09-28 21:26:31.230104625 +0000
Change: 2021-09-28 21:26:31.230104625 +0000
 Birth: 2021-09-28 21:24:42.508137185 +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: 1447414     Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:container_config_t:s0
Access: 2021-09-28 21:23:44.492028641 +0000
Modify: 2021-09-28 21:23:42.376024682 +0000
Change: 2021-09-28 21:23:42.376024682 +0000
 Birth: 2021-09-28 21:23:42.376024682 +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/jenkins2007104859700511030.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/jenkins5475475840405346052.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/jenkins8972358260565657877.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.QM6v3ELsGG
+ cat
+ chmod +x /tmp/tmp.QM6v3ELsGG
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.QM6v3ELsGG openshiftdevel:/tmp/tmp.QM6v3ELsGG
+ 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.QM6v3ELsGG"'
+ 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:43 ago on Tue 28 Sep 2021 09:12:59 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         580 kB/s |  38 kB     00:00    
(2/19): criu-3.13-5.fc30.x86_64.rpm             6.9 MB/s | 482 kB     00:00    
(3/19): fuse-overlayfs-0.7.5-2.fc30.x86_64.rpm  7.5 MB/s |  62 kB     00:00    
(4/19): fuse3-3.6.2-1.fc30.x86_64.rpm           3.9 MB/s |  53 kB     00:00    
(5/19): fuse3-libs-3.6.2-1.fc30.x86_64.rpm      8.3 MB/s |  88 kB     00:00    
(6/19): libnftnl-1.1.3-1.fc30.x86_64.rpm         10 MB/s |  71 kB     00:00    
(7/19): libvarlink-util-18-1.fc30.x86_64.rpm    7.4 MB/s |  47 kB     00:00    
(8/19): oniguruma-6.9.2-4.fc30.x86_64.rpm        18 MB/s | 198 kB     00:00    
(9/19): nftables-0.9.1-2.fc30.x86_64.rpm         18 MB/s | 289 kB     00:00    
(10/19): podman-docker-1.8.0-4.fc30.noarch.rpm  8.1 MB/s |  71 kB     00:00    
(11/19): podman-plugins-1.8.0-4.fc30.x86_64.rpm  13 MB/s | 1.3 MB     00:00    
(12/19): runc-1.0.0-102.dev.gitdc9208a.fc30.x86  16 MB/s | 2.7 MB     00:00    
(13/19): slirp4netns-0.4.0-4.git19d199a.fc30.x8 1.8 MB/s |  85 kB     00:00    
(14/19): jq-1.6-2.fc30.x86_64.rpm               2.4 MB/s | 168 kB     00:00    
(15/19): podman-1.8.0-4.fc30.x86_64.rpm          25 MB/s |  13 MB     00:00    
(16/19): libbsd-0.9.1-3.fc30.x86_64.rpm         732 kB/s | 100 kB     00:00    
(17/19): protobuf-c-1.3.1-2.fc30.x86_64.rpm     5.2 MB/s |  33 kB     00:00    
(18/19): libnet-1.1.6-17.fc30.x86_64.rpm        7.0 MB/s |  61 kB     00:00    
(19/19): containernetworking-plugins-0.8.5-1.fc  19 MB/s |  20 MB     00:01    
--------------------------------------------------------------------------------
Total                                            33 MB/s |  39 MB     00:01     
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/jenkins2189033030923158525.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/22504/api/json'\''))['\''result'\'']'
+ result=SUCCESS
+ cat
++ date +%s
+ cat /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/builds/22504/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/jenkins1298020459065713683.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.TuEZojBkwS
+ cat
+ chmod +x /tmp/tmp.TuEZojBkwS
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.TuEZojBkwS openshiftdevel:/tmp/tmp.TuEZojBkwS
+ 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.TuEZojBkwS"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ [[ -n {"type":"presubmit","job":"test_pull_request_crio_e2e_features_fedora","buildid":"1442957538264879107","prowjobid":"1a7c9de1-209f-11ec-addf-0a580a8047ae","refs":{"org":"cri-o","repo":"cri-o","base_ref":"main","base_sha":"fbe78c20cfa531e7e56c542aff2dc5061c67a093","pulls":[{"number":5321,"author":"dependabot","sha":"8c088319f06ded2ada93164fb84d918d9d63e3cc","title":"build(deps): bump k8s.io/api from 0.22.1 to 0.22.2"}]}} ]]
++ jq --compact-output '.buildid |= "22504"'
+ JOB_SPEC='{"type":"presubmit","job":"test_pull_request_crio_e2e_features_fedora","buildid":"22504","prowjobid":"1a7c9de1-209f-11ec-addf-0a580a8047ae","refs":{"org":"cri-o","repo":"cri-o","base_ref":"main","base_sha":"fbe78c20cfa531e7e56c542aff2dc5061c67a093","pulls":[{"number":5321,"author":"dependabot","sha":"8c088319f06ded2ada93164fb84d918d9d63e3cc","title":"build(deps): bump k8s.io/api from 0.22.1 to 0.22.2"}]}}'
+ sudo docker run -e 'JOB_SPEC={"type":"presubmit","job":"test_pull_request_crio_e2e_features_fedora","buildid":"22504","prowjobid":"1a7c9de1-209f-11ec-addf-0a580a8047ae","refs":{"org":"cri-o","repo":"cri-o","base_ref":"main","base_sha":"fbe78c20cfa531e7e56c542aff2dc5061c67a093","pulls":[{"number":5321,"author":"dependabot","sha":"8c088319f06ded2ada93164fb84d918d9d63e3cc","title":"build(deps): bump k8s.io/api from 0.22.1 to 0.22.2"}]}}' -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:809b39f1848ee7cb2dbba3bff7065c1997cd5b19424d2e33ce139262d43a8887
Copying blob sha256:85cea451eec057fa7e734548ca3ba6d779ed5836a3f9de14b8394575ef0d7d8e
Copying blob sha256:a90eeda06cad6e7218f1e3a07ca9a3f4a23779560e2905f0043f6cccd7cf037e
Copying blob sha256:df20fa9351a15782c64e6dddb2d4a6f50bf6d3688060a34c4014b0d9a752eb4c
Copying config sha256:c22090a8126675cfc5448e7572b706121c709056e340bae849a4313c76c272f3
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-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/crio.conf\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/e2e.log\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/generated/avc_denials.log\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/generated/filesystem.info\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/generated/installed_packages.log\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/generated/pid1.journal\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/generated/system.journal\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/journals/crio.service\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/journals/customcluster.service\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/journals/systemd-journald.service\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/junit_01.xml\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/junit_02.xml\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/junit_03.xml\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/junit_04.xml\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/junit_05.xml\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/junit_06.xml\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/kube-apiserver.log\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/kube-controller-manager.log\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/kube-proxy.log\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/kube-proxy.yaml\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/kube-scheduler.log\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"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/5321/test_pull_request_crio_e2e_features_fedora/22504/artifacts/kubelet.log\n","severity":"info","time":"2021-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_e2e_features_fedora/22504.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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:00Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:01Z"}
{"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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/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-09-28T21:28:01Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:02Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:02Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:02Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:02Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_e2e_features_fedora/22504.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-09-28T21:28:02Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:02Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:02Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:02Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:02Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:02Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:02Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:02Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5321/test_pull_request_crio_e2e_features_fedora/22504/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-09-28T21:28:02Z"}
{"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-09-28T21:28:02Z"}
{"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-09-28T21:28:02Z"}
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 06s] ##########
[workspace] $ /bin/bash /tmp/jenkins7152780714803288985.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-09-28 17:28:03.924451", 
    "item": "origin_ci_inventory_dir", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_region)  => {
    "changed": false, 
    "generated_timestamp": "2021-09-28 17:28:03.927240", 
    "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-09-28 17:28:04.882857", 
    "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-09-28 17:28:05.575009", 
    "msg": "Tags {'Name': 'oct-terminate'} created for resource i-09c6a94855ea49081."
}

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-09-28 17:28:06.930842", 
    "instance_ids": [
        "i-09c6a94855ea49081"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-06414c37e72c5e9e0"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0c9e1bfb9f479f799"
                }
            }, 
            "dns_name": "ec2-54-161-13-98.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-09c6a94855ea49081", 
            "image_id": "ami-038b90348c4438d19", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "openshift-dev", 
            "launch_time": "2021-09-28T21:01:31.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-6-79.ec2.internal", 
            "private_ip": "172.18.6.79", 
            "public_dns_name": "ec2-54-161-13-98.compute-1.amazonaws.com", 
            "public_ip": "54.161.13.98", 
            "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-09-28 17:28:07.191241", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_e2e_features_fedora/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.6.79.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-09-28 17:28:07.813677", 
    "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 44 events
[WS-CLEANUP] Deleting project workspace...
[WS-CLEANUP] Deferred wipeout is used...
[WS-CLEANUP] done
Finished: SUCCESS