Console Output

Skipping 424 KB.. Full Log
TASK [Update all packages RHEL 8, CentOS 8 and Fedora >= 30] *******************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/system-packages.yml:86
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [ensure directories exist as needed] **************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/system.yml:5
changed: [localhost] => (item=/opt/cni/bin) => {"changed": true, "gid": 0, "group": "root", "item": "/opt/cni/bin", "mode": "0755", "owner": "root", "path": "/opt/cni/bin", "secontext": "unconfined_u:object_r:usr_t:s0", "size": 6, "state": "directory", "uid": 0}
changed: [localhost] => (item=/etc/cni/net.d) => {"changed": true, "gid": 0, "group": "root", "item": "/etc/cni/net.d", "mode": "0755", "owner": "root", "path": "/etc/cni/net.d", "secontext": "unconfined_u:object_r:etc_t:s0", "size": 6, "state": "directory", "uid": 0}

TASK [set sysctl vm.overcommit_memory=1 for CentOS] ****************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/system.yml:13
skipping: [localhost] => {"changed": false, "skip_reason": "Conditional result was False"}

TASK [inject hostname into /etc/hosts] *****************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/system.yml:20
changed: [localhost] => {"backup": "", "changed": true, "msg": "line added"}

TASK [Flush the iptables] ******************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/system.yml:30
changed: [localhost] => {"changed": true, "cmd": ["iptables", "-F"], "delta": "0:00:00.014063", "end": "2021-12-08 14:54:59.459714", "rc": 0, "start": "2021-12-08 14:54:59.445651", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}

TASK [Enable localnet routing] *************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/system.yml:33
changed: [localhost] => {"changed": true}

TASK [Allow processes inside of containers to send ping] ***********************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/system.yml:39
changed: [localhost] => {"changed": true}

TASK [Add masquerade for localhost] ********************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/system.yml:45
changed: [localhost] => {"changed": true, "cmd": ["iptables", "-t", "nat", "-I", "POSTROUTING", "-s", "127.0.0.0/8", "!", "-d", "127.0.0.0/8", "-j", "MASQUERADE"], "delta": "0:00:00.050614", "end": "2021-12-08 14:55:00.206806", "rc": 0, "start": "2021-12-08 14:55:00.156192", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}

TASK [Update the kernel cmdline to include quota support] **********************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/system.yml:48
changed: [localhost] => {"changed": true, "cmd": ["grubby", "--update-kernel=ALL", "--args=rootflags=pquota"], "delta": "0:00:00.014912", "end": "2021-12-08 14:55:00.407159", "rc": 0, "start": "2021-12-08 14:55:00.392247", "stderr": "", "stderr_lines": [], "stdout": "", "stdout_lines": []}

TASK [Containers using cgroups and/or systemd after 7.5 are permitted] *********
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/system.yml:52
changed: [localhost] => {"changed": true, "name": "container_manage_cgroup"}

TASK [ensure Golang dir is empty first] ****************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/golang.yml:3
ok: [localhost] => {"changed": false, "path": "/usr/local/go", "state": "absent"}

TASK [fetch Golang] ************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/golang.yml:8
changed: [localhost] => {"changed": true, "dest": "/usr/local", "extract_results": {"cmd": ["/bin/gtar", "--extract", "-C", "/usr/local", "-z", "-f", "/tmp/ansible_odRqxd/go1.17.linux-amd64.tar.gz"], "err": "", "out": "", "rc": 0}, "gid": 0, "group": "root", "handler": "TgzArchive", "mode": "0755", "owner": "root", "secontext": "system_u:object_r:usr_t:s0", "size": 141, "src": "/tmp/ansible_odRqxd/go1.17.linux-amd64.tar.gz", "state": "directory", "uid": 0}

TASK [link go toolchain] *******************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/golang.yml:14
changed: [localhost] => (item=go) => {"changed": true, "dest": "/usr/bin/go", "gid": 0, "group": "root", "item": "go", "mode": "0777", "owner": "root", "secontext": "unconfined_u:object_r:bin_t:s0", "size": 20, "src": "/usr/local/go/bin/go", "state": "link", "uid": 0}
changed: [localhost] => (item=gofmt) => {"changed": true, "dest": "/usr/bin/gofmt", "gid": 0, "group": "root", "item": "gofmt", "mode": "0777", "owner": "root", "secontext": "unconfined_u:object_r:bin_t:s0", "size": 23, "src": "/usr/local/go/bin/gofmt", "state": "link", "uid": 0}

TASK [ensure user profile exists] **********************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/golang.yml:23
changed: [localhost] => {"changed": true, "dest": "/root/.profile", "gid": 0, "group": "root", "mode": "0644", "owner": "root", "secontext": "unconfined_u:object_r:admin_home_t:s0", "size": 0, "state": "file", "uid": 0}

TASK [set up PATH for Go toolchain and built binaries] *************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/golang.yml:28
changed: [localhost] => {"backup": "", "changed": true, "msg": "line added"}

TASK [set up directories] ******************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/golang.yml:37
changed: [localhost] => (item=/go/src/github.com/containernetworking) => {"changed": true, "gid": 0, "group": "root", "item": "/go/src/github.com/containernetworking", "mode": "0755", "owner": "root", "path": "/go/src/github.com/containernetworking", "secontext": "unconfined_u:object_r:default_t:s0", "size": 6, "state": "directory", "uid": 0}
changed: [localhost] => (item=/go/src/github.com/kubernetes-incubator) => {"changed": true, "gid": 0, "group": "root", "item": "/go/src/github.com/kubernetes-incubator", "mode": "0755", "owner": "root", "path": "/go/src/github.com/kubernetes-incubator", "secontext": "unconfined_u:object_r:default_t:s0", "size": 6, "state": "directory", "uid": 0}
changed: [localhost] => (item=/go/src/github.com/kubernetes-sigs) => {"changed": true, "gid": 0, "group": "root", "item": "/go/src/github.com/kubernetes-sigs", "mode": "0755", "owner": "root", "path": "/go/src/github.com/kubernetes-sigs", "secontext": "unconfined_u:object_r:default_t:s0", "size": 6, "state": "directory", "uid": 0}
ok: [localhost] => (item=/go/src/github.com/cri-o) => {"changed": false, "gid": 1001, "group": "origin", "item": "/go/src/github.com/cri-o", "mode": "0775", "owner": "origin", "path": "/go/src/github.com/cri-o", "secontext": "unconfined_u:object_r:default_t:s0", "size": 19, "state": "directory", "uid": 1001}
changed: [localhost] => (item=/go/src/github.com/k8s.io) => {"changed": true, "gid": 0, "group": "root", "item": "/go/src/github.com/k8s.io", "mode": "0755", "owner": "root", "path": "/go/src/github.com/k8s.io", "secontext": "unconfined_u:object_r:default_t:s0", "size": 6, "state": "directory", "uid": 0}
changed: [localhost] => (item=/go/src/github.com/bats-core) => {"changed": true, "gid": 0, "group": "root", "item": "/go/src/github.com/bats-core", "mode": "0755", "owner": "root", "path": "/go/src/github.com/bats-core", "secontext": "unconfined_u:object_r:default_t:s0", "size": 6, "state": "directory", "uid": 0}
changed: [localhost] => (item=/go/src/github.com/opencontainers) => {"changed": true, "gid": 0, "group": "root", "item": "/go/src/github.com/opencontainers", "mode": "0755", "owner": "root", "path": "/go/src/github.com/opencontainers", "secontext": "unconfined_u:object_r:default_t:s0", "size": 6, "state": "directory", "uid": 0}
changed: [localhost] => (item=/go/src/k8s.io/test-infra) => {"changed": true, "gid": 0, "group": "root", "item": "/go/src/k8s.io/test-infra", "mode": "0755", "owner": "root", "path": "/go/src/k8s.io/test-infra", "secontext": "unconfined_u:object_r:default_t:s0", "size": 6, "state": "directory", "uid": 0}

TASK [install Go tools and dependencies] ***************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/golang.yml:51
changed: [localhost] => (item=onsi/ginkgo/ginkgo) => {"changed": true, "cmd": "go get -u \"github.com/onsi/ginkgo/ginkgo\"", "delta": "0:00:09.554143", "end": "2021-12-08 14:55:28.466192", "item": "onsi/ginkgo/ginkgo", "rc": 0, "start": "2021-12-08 14:55:18.912049", "stderr": "go: downloading github.com/onsi/ginkgo v1.16.5\ngo: downloading github.com/go-task/slim-sprig v0.0.0-20210107165309-348f09dbbbc0\ngo: downloading golang.org/x/tools v0.0.0-20201224043029-2b0845dc783e\ngo: downloading github.com/nxadm/tail v1.4.8\ngo: downloading golang.org/x/sys v0.0.0-20210112080510-489259a85091\ngo: downloading gopkg.in/tomb.v1 v1.0.0-20141024135613-dd632973f1e7\ngo: downloading golang.org/x/sys v0.0.0-20211205182925-97ca703d548d\ngo: downloading github.com/fsnotify/fsnotify v1.4.9\ngo: downloading github.com/fsnotify/fsnotify v1.5.1\ngo: downloading golang.org/x/tools v0.1.8\ngo: downloading golang.org/x/sys v0.0.0-20210630005230-0f9fa26af87c\ngo get: installing executables with 'go get' in module mode is deprecated.\n\tUse 'go install pkg@version' instead.\n\tFor more information, see https://golang.org/doc/go-get-install-deprecation\n\tor run 'go help get' or 'go help install'.", "stderr_lines": ["go: downloading github.com/onsi/ginkgo v1.16.5", "go: downloading github.com/go-task/slim-sprig v0.0.0-20210107165309-348f09dbbbc0", "go: downloading golang.org/x/tools v0.0.0-20201224043029-2b0845dc783e", "go: downloading github.com/nxadm/tail v1.4.8", "go: downloading golang.org/x/sys v0.0.0-20210112080510-489259a85091", "go: downloading gopkg.in/tomb.v1 v1.0.0-20141024135613-dd632973f1e7", "go: downloading golang.org/x/sys v0.0.0-20211205182925-97ca703d548d", "go: downloading github.com/fsnotify/fsnotify v1.4.9", "go: downloading github.com/fsnotify/fsnotify v1.5.1", "go: downloading golang.org/x/tools v0.1.8", "go: downloading golang.org/x/sys v0.0.0-20210630005230-0f9fa26af87c", "go get: installing executables with 'go get' in module mode is deprecated.", "\tUse 'go install pkg@version' instead.", "\tFor more information, see https://golang.org/doc/go-get-install-deprecation", "\tor run 'go help get' or 'go help install'."], "stdout": "", "stdout_lines": []}
changed: [localhost] => (item=onsi/gomega) => {"changed": true, "cmd": "go get -u \"github.com/onsi/gomega\"", "delta": "0:00:06.292556", "end": "2021-12-08 14:55:34.920493", "item": "onsi/gomega", "rc": 0, "start": "2021-12-08 14:55:28.627937", "stderr": "go: downloading github.com/onsi/gomega v1.17.0\ngo: downloading golang.org/x/net v0.0.0-20210428140749-89ef3d95e781\ngo: downloading gopkg.in/yaml.v2 v2.4.0\ngo: downloading golang.org/x/net v0.0.0-20211208012354-db4efeb81f4b\ngo: downloading golang.org/x/text v0.3.6\ngo: downloading golang.org/x/text v0.3.7", "stderr_lines": ["go: downloading github.com/onsi/gomega v1.17.0", "go: downloading golang.org/x/net v0.0.0-20210428140749-89ef3d95e781", "go: downloading gopkg.in/yaml.v2 v2.4.0", "go: downloading golang.org/x/net v0.0.0-20211208012354-db4efeb81f4b", "go: downloading golang.org/x/text v0.3.6", "go: downloading golang.org/x/text v0.3.7"], "stdout": "", "stdout_lines": []}
changed: [localhost] => (item=jteeuwen/go-bindata/go-bindata) => {"changed": true, "cmd": "go get -u \"github.com/jteeuwen/go-bindata/go-bindata\"", "delta": "0:00:02.306666", "end": "2021-12-08 14:55:37.387244", "item": "jteeuwen/go-bindata/go-bindata", "rc": 0, "start": "2021-12-08 14:55:35.080578", "stderr": "go: downloading github.com/jteeuwen/go-bindata v3.0.7+incompatible\ngo get: installing executables with 'go get' in module mode is deprecated.\n\tUse 'go install pkg@version' instead.\n\tFor more information, see https://golang.org/doc/go-get-install-deprecation\n\tor run 'go help get' or 'go help install'.", "stderr_lines": ["go: downloading github.com/jteeuwen/go-bindata v3.0.7+incompatible", "go get: installing executables with 'go get' in module mode is deprecated.", "\tUse 'go install pkg@version' instead.", "\tFor more information, see https://golang.org/doc/go-get-install-deprecation", "\tor run 'go help get' or 'go help install'."], "stdout": "", "stdout_lines": []}

TASK [clone bats source repo] **************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/bats.yml:3
changed: [localhost] => {"after": "9086c47854652f2731861b40385689c85f12103f", "before": null, "changed": true}

TASK [install bats] ************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/bats.yml:9
changed: [localhost] => {"changed": true, "cmd": ["./install.sh", "/usr/local"], "delta": "0:00:00.034736", "end": "2021-12-08 14:55:38.738938", "rc": 0, "start": "2021-12-08 14:55:38.704202", "stderr": "", "stderr_lines": [], "stdout": "Installed Bats to /usr/local/bin/bats", "stdout_lines": ["Installed Bats to /usr/local/bin/bats"]}

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

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

TASK [build cri-tools] *********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-tools.yml:10
changed: [localhost] => {"changed": true, "chdir": "/go/src/github.com/kubernetes-sigs/cri-tools", "params": null, "stderr": "", "stderr_lines": [], "stdout": "CGO_ENABLED=0 GO111MODULE=on go test -mod=vendor -c -o /go/src/github.com/kubernetes-sigs/cri-tools/build/bin/critest \\\n\t-ldflags '-X github.com/kubernetes-sigs/cri-tools/pkg/version.Version=1.22.0' \\\n\t-trimpath \\\n\t-tags 'selinux' \\\n     github.com/kubernetes-sigs/cri-tools/cmd/critest\nCGO_ENABLED=0 GO111MODULE=on go build -mod=vendor -o /go/src/github.com/kubernetes-sigs/cri-tools/build/bin/crictl \\\n\t-ldflags '-X github.com/kubernetes-sigs/cri-tools/pkg/version.Version=1.22.0' \\\n\t-trimpath \\\n\t-tags 'selinux' \\\n\tgithub.com/kubernetes-sigs/cri-tools/cmd/crictl", "stdout_lines": ["CGO_ENABLED=0 GO111MODULE=on go test -mod=vendor -c -o /go/src/github.com/kubernetes-sigs/cri-tools/build/bin/critest \\", "\t-ldflags '-X github.com/kubernetes-sigs/cri-tools/pkg/version.Version=1.22.0' \\", "\t-trimpath \\", "\t-tags 'selinux' \\", "     github.com/kubernetes-sigs/cri-tools/cmd/critest", "CGO_ENABLED=0 GO111MODULE=on go build -mod=vendor -o /go/src/github.com/kubernetes-sigs/cri-tools/build/bin/crictl \\", "\t-ldflags '-X github.com/kubernetes-sigs/cri-tools/pkg/version.Version=1.22.0' \\", "\t-trimpath \\", "\t-tags 'selinux' \\", "\tgithub.com/kubernetes-sigs/cri-tools/cmd/crictl"], "target": null}

TASK [link crictl and critest] *************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/cri-tools.yml:14
changed: [localhost] => (item=critest) => {"changed": true, "dest": "/usr/bin/critest", "gid": 0, "group": "root", "item": "critest", "mode": "0777", "owner": "root", "secontext": "unconfined_u:object_r:bin_t:s0", "size": 62, "src": "/go/src/github.com/kubernetes-sigs/cri-tools/build/bin/critest", "state": "link", "uid": 0}
changed: [localhost] => (item=crictl) => {"changed": true, "dest": "/usr/bin/crictl", "gid": 0, "group": "root", "item": "crictl", "mode": "0777", "owner": "root", "secontext": "unconfined_u:object_r:bin_t:s0", "size": 61, "src": "/go/src/github.com/kubernetes-sigs/cri-tools/build/bin/crictl", "state": "link", "uid": 0}

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

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:01.213451", "end": "2021-12-08 14:58:11.497652", "rc": 0, "start": "2021-12-08 14:58:10.284201", "stderr": "", "stderr_lines": [], "stdout": "Downloading https://github.com/coreos/etcd/releases/download/v3.4.13/etcd-v3.4.13-linux-amd64.tar.gz succeed\netcd v3.4.13 installed. To use:\nexport PATH=\"/go/src/k8s.io/kubernetes/third_party/etcd:${PATH}\"", "stdout_lines": ["Downloading https://github.com/coreos/etcd/releases/download/v3.4.13/etcd-v3.4.13-linux-amd64.tar.gz succeed", "etcd v3.4.13 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
changed: [localhost] => {"changed": true, "chdir": "/go/src/k8s.io/kubernetes", "params": null, "stderr": "", "stderr_lines": [], "stdout": "+++ [1208 14:58:11] Verifying Prerequisites....", "stdout_lines": ["+++ [1208 14:58:11] Verifying Prerequisites...."], "target": "clean"}

TASK [build kubernetes] ********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/kubernetes.yml:30
changed: [localhost] => {"changed": true, "chdir": "/go/src/k8s.io/kubernetes", "params": null, "stderr": "", "stderr_lines": [], "stdout": "+++ [1208 14:59:26] 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": ["+++ [1208 14:59:26] 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
changed: [localhost] => {"changed": true, "checksum": "6eac4634e0e56cc8e358e785bac2ce8939e438f2", "dest": "/etc/systemd/system/customcluster.service", "gid": 0, "group": "root", "md5sum": "5bc5ef927fb2b1e552af3e82d476e13b", "mode": "0644", "owner": "root", "secontext": "system_u:object_r:systemd_unit_file_t:s0", "size": 205, "src": "/home/origin/.ansible/tmp/ansible-tmp-1638976224.7-86539986998030/source", "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": "03af6e09fb7d305cd18216ff99a7f9800181a5fd", "dest": "/usr/local/bin/createcluster.sh", "gid": 0, "group": "root", "md5sum": "80f701cdb11ca53a1caedd02351d7272", "mode": "0771", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 1058, "src": "/home/origin/.ansible/tmp/ansible-tmp-1638976225.66-221500138704114/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 added"}

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 added"}

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": "2c10a8289d24c1364299461846146bea2e857bde", "dest": "/go/bin/kubectl", "gid": 0, "group": "root", "md5sum": "bab45781704f95471ab5aa4bf05c6d5e", "mode": "0755", "owner": "root", "secontext": "system_u:object_r:default_t:s0", "size": 44818432, "src": "/home/origin/.ansible/tmp/ansible-tmp-1638976226.37-169123155236267/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": "37b3589cd3802d25916c42401999a73404c4e37f", "before": null, "changed": true}

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.553526", "end": "2021-12-08 15:12:01.879802", "rc": 0, "start": "2021-12-08 15:10:47.326276", "stderr": "go: downloading cloud.google.com/go/storage v1.12.0\ngo: downloading github.com/Azure/azure-sdk-for-go v42.3.0+incompatible\ngo: downloading cloud.google.com/go v0.81.0\ngo: downloading github.com/Azure/azure-storage-blob-go v0.8.0\ngo: downloading github.com/Azure/go-autorest/autorest/adal v0.9.5\ngo: downloading github.com/Azure/go-autorest/autorest v0.11.12\ngo: downloading github.com/Azure/go-autorest v14.2.0+incompatible\ngo: downloading github.com/aws/aws-sdk-go v1.37.22\ngo: downloading github.com/pelletier/go-toml v1.9.3\ngo: downloading github.com/satori/go.uuid v1.2.0\ngo: downloading github.com/spf13/pflag v1.0.5\ngo: downloading golang.org/x/crypto v0.0.0-20210220033148-5ea612d1eb83\ngo: downloading sigs.k8s.io/boskos v0.0.0-20210730172138-093b54882439\ngo: downloading github.com/googleapis/gax-go/v2 v2.0.5\ngo: downloading github.com/googleapis/gax-go v2.0.2+incompatible\ngo: downloading google.golang.org/api v0.44.0\ngo: downloading google.golang.org/genproto v0.0.0-20210602131652-f16073e35f0c\ngo: downloading github.com/Azure/go-autorest/autorest/to v0.3.0\ngo: downloading github.com/Azure/go-autorest/tracing v0.6.0\ngo: downloading github.com/Azure/go-autorest/autorest/validation v0.2.0\ngo: downloading github.com/Azure/go-autorest/autorest/date v0.3.0\ngo: downloading github.com/form3tech-oss/jwt-go v3.2.2+incompatible\ngo: downloading github.com/Azure/go-autorest/logger v0.2.0\ngo: downloading github.com/Azure/azure-pipeline-go v0.2.2\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/hashicorp/go-multierror v1.1.0\ngo: downloading github.com/sirupsen/logrus v1.8.1\ngo: downloading github.com/golang/protobuf v1.5.2\ngo: downloading github.com/jstemmer/go-junit-report v0.9.1\ngo: downloading golang.org/x/lint v0.0.0-20190409202823-959b441ac422\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/mattn/go-ieproxy v0.0.1\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 k8s.io/klog v1.0.0\ngo: downloading github.com/hashicorp/errwrap v1.0.0\ngo: downloading sigs.k8s.io/yaml v1.2.0\ngo: downloading google.golang.org/protobuf v1.26.0\ngo: downloading github.com/golang/groupcache v0.0.0-20200121045136-8c9f03a8e57e\ngo: downloading github.com/jmespath/go-jmespath v0.4.0\ngo: downloading gopkg.in/inf.v0 v0.9.1\ngo: downloading github.com/google/go-cmp v0.5.6\ngo: downloading sigs.k8s.io/structured-merge-diff/v4 v4.1.2\ngo: downloading github.com/googleapis/gnostic v0.4.1\ngo: downloading sigs.k8s.io/structured-merge-diff v1.0.1\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/davecgh/go-spew v1.1.1\ngo: downloading github.com/json-iterator/go v1.1.11\ngo: downloading github.com/modern-go/reflect2 v1.0.1\ngo: downloading github.com/prometheus/client_golang v1.11.0\ngo: downloading golang.org/x/xerrors v0.0.0-20200804184101-5ec99f83aff1\ngo: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd\ngo: downloading github.com/beorn7/perks v1.0.1\ngo: downloading github.com/cespare/xxhash/v2 v2.1.1\ngo: downloading github.com/prometheus/client_model v0.2.0\ngo: downloading github.com/cespare/xxhash v1.1.0\ngo: downloading github.com/prometheus/common v0.26.0\ngo: downloading github.com/prometheus/procfs v0.6.0\ngo: downloading github.com/matttproud/golang_protobuf_extensions v1.0.2-0.20181231171920-c182affec369", "stderr_lines": ["go: downloading cloud.google.com/go/storage v1.12.0", "go: downloading github.com/Azure/azure-sdk-for-go v42.3.0+incompatible", "go: downloading cloud.google.com/go v0.81.0", "go: downloading github.com/Azure/azure-storage-blob-go v0.8.0", "go: downloading github.com/Azure/go-autorest/autorest/adal v0.9.5", "go: downloading github.com/Azure/go-autorest/autorest v0.11.12", "go: downloading github.com/Azure/go-autorest v14.2.0+incompatible", "go: downloading github.com/aws/aws-sdk-go v1.37.22", "go: downloading github.com/pelletier/go-toml v1.9.3", "go: downloading github.com/satori/go.uuid v1.2.0", "go: downloading github.com/spf13/pflag v1.0.5", "go: downloading golang.org/x/crypto v0.0.0-20210220033148-5ea612d1eb83", "go: downloading sigs.k8s.io/boskos v0.0.0-20210730172138-093b54882439", "go: downloading github.com/googleapis/gax-go/v2 v2.0.5", "go: downloading github.com/googleapis/gax-go v2.0.2+incompatible", "go: downloading google.golang.org/api v0.44.0", "go: downloading google.golang.org/genproto v0.0.0-20210602131652-f16073e35f0c", "go: downloading github.com/Azure/go-autorest/autorest/to v0.3.0", "go: downloading github.com/Azure/go-autorest/tracing v0.6.0", "go: downloading github.com/Azure/go-autorest/autorest/validation v0.2.0", "go: downloading github.com/Azure/go-autorest/autorest/date v0.3.0", "go: downloading github.com/form3tech-oss/jwt-go v3.2.2+incompatible", "go: downloading github.com/Azure/go-autorest/logger v0.2.0", "go: downloading github.com/Azure/azure-pipeline-go v0.2.2", "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/hashicorp/go-multierror v1.1.0", "go: downloading github.com/sirupsen/logrus v1.8.1", "go: downloading github.com/golang/protobuf v1.5.2", "go: downloading github.com/jstemmer/go-junit-report v0.9.1", "go: downloading golang.org/x/lint v0.0.0-20190409202823-959b441ac422", "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/mattn/go-ieproxy v0.0.1", "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 k8s.io/klog v1.0.0", "go: downloading github.com/hashicorp/errwrap v1.0.0", "go: downloading sigs.k8s.io/yaml v1.2.0", "go: downloading google.golang.org/protobuf v1.26.0", "go: downloading github.com/golang/groupcache v0.0.0-20200121045136-8c9f03a8e57e", "go: downloading github.com/jmespath/go-jmespath v0.4.0", "go: downloading gopkg.in/inf.v0 v0.9.1", "go: downloading github.com/google/go-cmp v0.5.6", "go: downloading sigs.k8s.io/structured-merge-diff/v4 v4.1.2", "go: downloading github.com/googleapis/gnostic v0.4.1", "go: downloading sigs.k8s.io/structured-merge-diff v1.0.1", "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/davecgh/go-spew v1.1.1", "go: downloading github.com/json-iterator/go v1.1.11", "go: downloading github.com/modern-go/reflect2 v1.0.1", "go: downloading github.com/prometheus/client_golang v1.11.0", "go: downloading golang.org/x/xerrors v0.0.0-20200804184101-5ec99f83aff1", "go: downloading github.com/modern-go/concurrent v0.0.0-20180306012644-bacd9c7ef1dd", "go: downloading github.com/beorn7/perks v1.0.1", "go: downloading github.com/cespare/xxhash/v2 v2.1.1", "go: downloading github.com/prometheus/client_model v0.2.0", "go: downloading github.com/cespare/xxhash v1.1.0", "go: downloading github.com/prometheus/common v0.26.0", "go: downloading github.com/prometheus/procfs v0.6.0", "go: downloading github.com/matttproud/golang_protobuf_extensions v1.0.2-0.20181231171920-c182affec369"], "stdout": "", "stdout_lines": []}

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": "4b22d8e446bdf59586c158c8930be1ceecec8d0c", "before": null, "changed": true}

TASK [build runc] **************************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/runc.yml:9
changed: [localhost] => {"changed": true, "chdir": "/go/src/github.com/opencontainers/runc", "params": {"BUILDTAGS": "seccomp selinux"}, "stderr": "", "stderr_lines": [], "stdout": "go build -trimpath \"-buildmode=pie\"  -tags \"seccomp selinux\" -ldflags \"-X main.gitCommit=v1.0.0-428-g4b22d8e -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-428-g4b22d8e -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
changed: [localhost] => {"changed": true, "chdir": "/go/src/github.com/opencontainers/runc", "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
changed: [localhost] => {"changed": true, "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 [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 [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] => {"changed": false, "skip_reason": "Conditional result was False"}

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 [clone plugins source repo] ***********************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/plugins.yml:3
changed: [localhost] => {"after": "189d0c06aa6da0c4f052d3831b091e6ea79e6675", "before": null, "changed": true}

TASK [build plugins] ***********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/plugins.yml:9
changed: [localhost] => {"changed": true, "cmd": ["./build_linux.sh"], "delta": "0:00:10.677412", "end": "2021-12-08 15:12:41.149172", "rc": 0, "start": "2021-12-08 15:12:30.471760", "stderr": "", "stderr_lines": [], "stdout": "Building plugins \n  bandwidth\n  firewall\n  portmap\n  sbr\n  tuning\n  vrf\n  bridge\n  host-device\n  ipvlan\n  loopback\n  macvlan\n  ptp\n  vlan\n  dhcp\n  host-local\n  static", "stdout_lines": ["Building plugins ", "  bandwidth", "  firewall", "  portmap", "  sbr", "  tuning", "  vrf", "  bridge", "  host-device", "  ipvlan", "  loopback", "  macvlan", "  ptp", "  vlan", "  dhcp", "  host-local", "  static"]}

TASK [install plugins] *********************************************************
task path: /go/src/github.com/cri-o/cri-o/contrib/test/integration/build/plugins.yml:14
changed: [localhost] => (item=bridge) => {"changed": true, "checksum": "d34c79c12b6515e230a2d6d3ec33a0f17157d23d", "dest": "/opt/cni/bin/bridge", "gid": 0, "group": "root", "item": "bridge", "md5sum": "d0a3e07593f34aa266e5638f1ccf667f", "mode": "0655", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 4206490, "src": "/go/src/github.com/containernetworking/plugins/bin/bridge", "state": "file", "uid": 0}
changed: [localhost] => (item=dhcp) => {"changed": true, "checksum": "8e9c32384679d991b2954d852be9803d5afb72d2", "dest": "/opt/cni/bin/dhcp", "gid": 0, "group": "root", "item": "dhcp", "md5sum": "f4ce15ca16381a80877e10069114fdc1", "mode": "0655", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 9780846, "src": "/go/src/github.com/containernetworking/plugins/bin/dhcp", "state": "file", "uid": 0}
failed: [localhost] (item=flannel) => {"changed": false, "item": "flannel", "msg": "Source /go/src/github.com/containernetworking/plugins/bin/flannel not found"}
changed: [localhost] => (item=host-local) => {"changed": true, "checksum": "5f3b6120bb40ee5716f303881d2371f2da747d9b", "dest": "/opt/cni/bin/host-local", "gid": 0, "group": "root", "item": "host-local", "md5sum": "2a0bd80ac928685dcb09cffc121e0334", "mode": "0655", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 3257703, "src": "/go/src/github.com/containernetworking/plugins/bin/host-local", "state": "file", "uid": 0}
changed: [localhost] => (item=ipvlan) => {"changed": true, "checksum": "b8612f233c2b673090ac0617e8a356b699168f0c", "dest": "/opt/cni/bin/ipvlan", "gid": 0, "group": "root", "item": "ipvlan", "md5sum": "5a0efc25f6e4ec414fdeb3feadf9b329", "mode": "0655", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 3939073, "src": "/go/src/github.com/containernetworking/plugins/bin/ipvlan", "state": "file", "uid": 0}
changed: [localhost] => (item=loopback) => {"changed": true, "checksum": "3e52fa481cca1ae17b6e420055692a09ce93e8fc", "dest": "/opt/cni/bin/loopback", "gid": 0, "group": "root", "item": "loopback", "md5sum": "19f6ec2bace6cfabbe9ffcec5dfd28fb", "mode": "0655", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 3314257, "src": "/go/src/github.com/containernetworking/plugins/bin/loopback", "state": "file", "uid": 0}
changed: [localhost] => (item=macvlan) => {"changed": true, "checksum": "bea58fab83d2f4e61ee73188809bb827bd7ac429", "dest": "/opt/cni/bin/macvlan", "gid": 0, "group": "root", "item": "macvlan", "md5sum": "c69ee4e5952bb255026db5c4dee25cba", "mode": "0655", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 4019289, "src": "/go/src/github.com/containernetworking/plugins/bin/macvlan", "state": "file", "uid": 0}
changed: [localhost] => (item=ptp) => {"changed": true, "checksum": "1f2d55e535397b51069bc507d835141c71981706", "dest": "/opt/cni/bin/ptp", "gid": 0, "group": "root", "item": "ptp", "md5sum": "b7e22ec3f06d150988e797613ee646c3", "mode": "0655", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 4120838, "src": "/go/src/github.com/containernetworking/plugins/bin/ptp", "state": "file", "uid": 0}
changed: [localhost] => (item=tuning) => {"changed": true, "checksum": "ab4da1f95eedd1a47f1d7dd36edde7cf9f871294", "dest": "/opt/cni/bin/tuning", "gid": 0, "group": "root", "item": "tuning", "md5sum": "a8af766f3bd9364d9d77a202ac747970", "mode": "0655", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 3473575, "src": "/go/src/github.com/containernetworking/plugins/bin/tuning", "state": "file", "uid": 0}
changed: [localhost] => (item=vlan) => {"changed": true, "checksum": "500ae8a2223f1dc369ed1087150d8dcaa2e946a5", "dest": "/opt/cni/bin/vlan", "gid": 0, "group": "root", "item": "vlan", "md5sum": "ce5b6c7c875e866dca0977fd872ee6ca", "mode": "0655", "owner": "root", "secontext": "system_u:object_r:bin_t:s0", "size": 3937380, "src": "/go/src/github.com/containernetworking/plugins/bin/vlan", "state": "file", "uid": 0}
	to retry, use: --limit @/go/src/github.com/cri-o/cri-o/contrib/test/integration/main.retry

PLAY RECAP *********************************************************************
localhost                  : ok=43   changed=41   unreachable=0    failed=1   

++ export status=FAILURE
++ status=FAILURE
+ set +o xtrace
########## FINISHED STAGE: FAILURE: SET UP CRI-O DEPENDENCIES [00h 25m 48s] ##########
Build step 'Execute shell' marked build as failure
[PostBuildScript] - [INFO] Executing post build scripts.
[workspace] $ /bin/bash /tmp/jenkins1298013269634853745.sh
########## STARTING STAGE: DOWNLOAD ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/activate ]]
+ source /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/artifacts/gathered
+ rm -rf /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/artifacts/gathered
+ mkdir -p /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat '/tmp/artifacts/*'
stat: cannot stat ‘/tmp/artifacts/*’: No such file or directory
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kubelet.log
stat: cannot stat ‘/tmp/kubelet.log’: No such file or directory
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-apiserver.log
stat: cannot stat ‘/tmp/kube-apiserver.log’: No such file or directory
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-controller-manager.log
stat: cannot stat ‘/tmp/kube-controller-manager.log’: No such file or directory
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-proxy.log
stat: cannot stat ‘/tmp/kube-proxy.log’: No such file or directory
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-proxy.yaml
stat: cannot stat ‘/tmp/kube-proxy.yaml’: No such file or directory
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/kube-scheduler.log
stat: cannot stat ‘/tmp/kube-scheduler.log’: No such file or directory
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /etc/crio/crio.conf
stat: cannot stat ‘/etc/crio/crio.conf’: No such file or directory
+ tree /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/artifacts/gathered
/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/artifacts/gathered

0 directories, 0 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins8806104603473456052.sh
########## STARTING STAGE: GENERATE ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/activate ]]
+ source /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/artifacts/generated
+ rm -rf /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/artifacts/generated
+ mkdir /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/artifacts/generated
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo pvs && sudo vgs && sudo lvs 2>&1'
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo yum list installed 2>&1'
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo journalctl --no-pager --boot 2>&1'
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/workspace/artifacts/generated
/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/jenkins7564412981503359456.sh
########## STARTING STAGE: FETCH SYSTEMD JOURNALS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/activate ]]
+ source /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/artifacts/journals
+ rm -rf /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/artifacts/journals
+ mkdir /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/artifacts/journals
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/workspace/artifacts/journals
/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/artifacts/journals
├── crio.service
├── customcluster.service
└── systemd-journald.service

0 directories, 3 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins2905825001765099516.sh
########## STARTING STAGE: CREATE /DATA, INSTALL JQ, DOCKER, AND START DOCKERD ##########
+ [[ -s /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/activate ]]
+ source /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config
++ mktemp
+ script=/tmp/tmp.StJKOMRQM3
+ cat
+ chmod +x /tmp/tmp.StJKOMRQM3
+ scp -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.StJKOMRQM3 openshiftdevel:/tmp/tmp.StJKOMRQM3
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.StJKOMRQM3"'
+ 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 yum install -y https://dl.fedoraproject.org/pub/epel/epel-release-latest-7.noarch.rpm
Loaded plugins: amazon-id, search-disabled-repos
Examining /var/tmp/yum-root-n7mSdS/epel-release-latest-7.noarch.rpm: epel-release-7-14.noarch
Marking /var/tmp/yum-root-n7mSdS/epel-release-latest-7.noarch.rpm to be installed
Resolving Dependencies
--> Running transaction check
---> Package epel-release.noarch 0:7-14 will be installed
--> Finished Dependency Resolution

Dependencies Resolved

================================================================================
 Package          Arch       Version    Repository                         Size
================================================================================
Installing:
 epel-release     noarch     7-14       /epel-release-latest-7.noarch      25 k

Transaction Summary
================================================================================
Install  1 Package

Total size: 25 k
Installed size: 25 k
Downloading packages:
Running transaction check
Running transaction test
Transaction test succeeded
Running transaction
  Installing : epel-release-7-14.noarch                                     1/1 
  Verifying  : epel-release-7-14.noarch                                     1/1 

Installed:
  epel-release.noarch 0:7-14                                                    

Complete!
+ sudo yum install -y jq docker
Loaded plugins: amazon-id, search-disabled-repos
Resolving Dependencies
--> Running transaction check
---> Package docker.x86_64 2:1.13.1-208.git7d71120.el7_9 will be installed
--> Processing Dependency: docker-common = 2:1.13.1-208.git7d71120.el7_9 for package: 2:docker-1.13.1-208.git7d71120.el7_9.x86_64
--> Processing Dependency: docker-client = 2:1.13.1-208.git7d71120.el7_9 for package: 2:docker-1.13.1-208.git7d71120.el7_9.x86_64
---> Package jq.x86_64 0:1.6-2.el7 will be installed
--> Processing Dependency: libonig.so.5()(64bit) for package: jq-1.6-2.el7.x86_64
--> Running transaction check
---> Package docker-client.x86_64 2:1.13.1-208.git7d71120.el7_9 will be installed
---> Package docker-common.x86_64 2:1.13.1-208.git7d71120.el7_9 will be installed
--> Processing Dependency: docker-rhel-push-plugin = 2:1.13.1-208.git7d71120.el7_9 for package: 2:docker-common-1.13.1-208.git7d71120.el7_9.x86_64
--> Processing Dependency: container-storage-setup >= 0.9.0-1 for package: 2:docker-common-1.13.1-208.git7d71120.el7_9.x86_64
---> Package oniguruma.x86_64 0:6.8.2-1.el7 will be installed
--> Running transaction check
---> Package container-storage-setup.noarch 0:0.11.0-2.git5eaf76c.el7 will be installed
---> Package docker-rhel-push-plugin.x86_64 2:1.13.1-208.git7d71120.el7_9 will be installed
--> Finished Dependency Resolution

Dependencies Resolved

================================================================================
 Package Arch   Version                       Repository                   Size
================================================================================
Installing:
 docker  x86_64 2:1.13.1-208.git7d71120.el7_9 oso-rhui-rhel-server-extras  17 M
 jq      x86_64 1.6-2.el7                     epel                        167 k
Installing for dependencies:
 container-storage-setup
         noarch 0.11.0-2.git5eaf76c.el7       oso-rhui-rhel-server-extras  35 k
 docker-client
         x86_64 2:1.13.1-208.git7d71120.el7_9 oso-rhui-rhel-server-extras 3.9 M
 docker-common
         x86_64 2:1.13.1-208.git7d71120.el7_9 oso-rhui-rhel-server-extras 101 k
 docker-rhel-push-plugin
         x86_64 2:1.13.1-208.git7d71120.el7_9 oso-rhui-rhel-server-extras 2.0 M
 oniguruma
         x86_64 6.8.2-1.el7                   epel                        181 k

Transaction Summary
================================================================================
Install  2 Packages (+5 Dependent packages)

Total download size: 24 M
Installed size: 84 M
Downloading packages:
warning: /var/cache/yum/x86_64/7Server/epel/packages/jq-1.6-2.el7.x86_64.rpm: Header V3 RSA/SHA256 Signature, key ID 352c64e5: NOKEY
Public key for jq-1.6-2.el7.x86_64.rpm is not installed
--------------------------------------------------------------------------------
Total                                               38 MB/s |  24 MB  00:00     
Retrieving key from file:///etc/pki/rpm-gpg/RPM-GPG-KEY-EPEL-7
Importing GPG key 0x352C64E5:
 Userid     : "Fedora EPEL (7) <epel@fedoraproject.org>"
 Fingerprint: 91e9 7d7c 4a5e 96f1 7f3e 888f 6a2f aea2 352c 64e5
 Package    : epel-release-7-14.noarch (@/epel-release-latest-7.noarch)
 From       : /etc/pki/rpm-gpg/RPM-GPG-KEY-EPEL-7
Running transaction check
Running transaction test
Transaction test succeeded
Running transaction
  Installing : oniguruma-6.8.2-1.el7.x86_64                                 1/7 
  Installing : 2:docker-rhel-push-plugin-1.13.1-208.git7d71120.el7_9.x86_   2/7 
  Installing : container-storage-setup-0.11.0-2.git5eaf76c.el7.noarch       3/7 
  Installing : 2:docker-common-1.13.1-208.git7d71120.el7_9.x86_64           4/7 
  Installing : 2:docker-client-1.13.1-208.git7d71120.el7_9.x86_64           5/7 
  Installing : 2:docker-1.13.1-208.git7d71120.el7_9.x86_64                  6/7 
  Installing : jq-1.6-2.el7.x86_64                                          7/7 
  Verifying  : 2:docker-common-1.13.1-208.git7d71120.el7_9.x86_64           1/7 
  Verifying  : 2:docker-1.13.1-208.git7d71120.el7_9.x86_64                  2/7 
  Verifying  : 2:docker-client-1.13.1-208.git7d71120.el7_9.x86_64           3/7 
  Verifying  : container-storage-setup-0.11.0-2.git5eaf76c.el7.noarch       4/7 
  Verifying  : jq-1.6-2.el7.x86_64                                          5/7 
  Verifying  : 2:docker-rhel-push-plugin-1.13.1-208.git7d71120.el7_9.x86_   6/7 
  Verifying  : oniguruma-6.8.2-1.el7.x86_64                                 7/7 

Installed:
  docker.x86_64 2:1.13.1-208.git7d71120.el7_9       jq.x86_64 0:1.6-2.el7      

Dependency Installed:
  container-storage-setup.noarch 0:0.11.0-2.git5eaf76c.el7                      
  docker-client.x86_64 2:1.13.1-208.git7d71120.el7_9                            
  docker-common.x86_64 2:1.13.1-208.git7d71120.el7_9                            
  docker-rhel-push-plugin.x86_64 2:1.13.1-208.git7d71120.el7_9                  
  oniguruma.x86_64 0:6.8.2-1.el7                                                

Complete!
+ sudo systemctl enable --now docker
Created symlink from /etc/systemd/system/multi-user.target.wants/docker.service to /usr/lib/systemd/system/docker.service.
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: CREATE /DATA, INSTALL JQ, DOCKER, AND START DOCKERD [00h 01m 00s] ##########
[workspace] $ /bin/bash /tmp/jenkins4760089543653288464.sh
########## STARTING STAGE: ASSEMBLE GCS OUTPUT ##########
+ [[ -s /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/activate ]]
+ source /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/1555/api/json'\''))['\''result'\'']'
+ result=FAILURE
+ cat
++ date +%s
+ cat /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/builds/1555/log
+ cp -r 'artifacts/gathered/*' gcs/artifacts/
cp: cannot stat ‘artifacts/gathered/*’: No such file or directory
+ true
+ 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/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config -r /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/gcs openshiftdevel:/data
+ scp -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/jenkins1502762020755412554.sh
########## STARTING STAGE: PUSH THE ARTIFACTS AND METADATA ##########
+ [[ -s /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/activate ]]
+ source /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config
++ mktemp
+ script=/tmp/tmp.pSIukRohMa
+ cat
+ chmod +x /tmp/tmp.pSIukRohMa
+ scp -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.pSIukRohMa openshiftdevel:/tmp/tmp.pSIukRohMa
+ ssh -F /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.pSIukRohMa"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ [[ -n {"type":"periodic","job":"ami_build_origin_int_rhel_crio","buildid":"1468591624530432000","prowjobid":"c679910d-5834-11ec-8f97-0a580a80115c"} ]]
++ jq --compact-output '.buildid |= "1555"'
+ JOB_SPEC='{"type":"periodic","job":"ami_build_origin_int_rhel_crio","buildid":"1555","prowjobid":"c679910d-5834-11ec-8f97-0a580a80115c"}'
+ sudo docker run -e 'JOB_SPEC={"type":"periodic","job":"ami_build_origin_int_rhel_crio","buildid":"1555","prowjobid":"c679910d-5834-11ec-8f97-0a580a80115c"}' -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
Unable to find image 'registry.ci.openshift.org/ci/gcsupload:latest' locally
Trying to pull repository registry.ci.openshift.org/ci/gcsupload ... 
latest: Pulling from registry.ci.openshift.org/ci/gcsupload
df20fa9351a1: Pulling fs layer
809b39f1848e: Pulling fs layer
afb9ced3679f: Pulling fs layer
85cea451eec0: Pulling fs layer
85cea451eec0: Waiting
809b39f1848e: Verifying Checksum
809b39f1848e: Download complete
df20fa9351a1: Verifying Checksum
df20fa9351a1: Download complete
85cea451eec0: Verifying Checksum
85cea451eec0: Download complete
df20fa9351a1: Pull complete
809b39f1848e: Pull complete
afb9ced3679f: Verifying Checksum
afb9ced3679f: Download complete
afb9ced3679f: Pull complete
85cea451eec0: Pull complete
Digest: sha256:15c4b38b0a7211e8a863a8e5aad0f7f2ae3cbb62b880173465de18b0c5a3afc5
Status: Downloaded newer image for registry.ci.openshift.org/ci/gcsupload:latest
{"component":"gcsupload","file":"prow/gcsupload/run.go:194","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts","level":"info","msg":"Gathering artifacts from artifact directory: /data/gcs/artifacts","severity":"info","time":"2021-12-08T15:13:55Z"}
{"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 logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/avc_denials.log\n","severity":"info","time":"2021-12-08T15:13:55Z"}
{"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 logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/filesystem.info\n","severity":"info","time":"2021-12-08T15:13:55Z"}
{"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 logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/installed_packages.log\n","severity":"info","time":"2021-12-08T15:13:55Z"}
{"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 logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/pid1.journal\n","severity":"info","time":"2021-12-08T15:13:55Z"}
{"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 logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/system.journal\n","severity":"info","time":"2021-12-08T15:13:55Z"}
{"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 logs/ami_build_origin_int_rhel_crio/1555/artifacts/journals/crio.service\n","severity":"info","time":"2021-12-08T15:13:55Z"}
{"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 logs/ami_build_origin_int_rhel_crio/1555/artifacts/journals/customcluster.service\n","severity":"info","time":"2021-12-08T15:13:55Z"}
{"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 logs/ami_build_origin_int_rhel_crio/1555/artifacts/journals/systemd-journald.service\n","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/journals/systemd-journald.service","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/build-log.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/finished.json","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/avc_denials.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/filesystem.info","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/pid1.journal","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/system.journal","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/journals/customcluster.service","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/installed_packages.log","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/journals/crio.service","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/started.json","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/finished.json","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/build-log.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/avc_denials.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/started.json","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/system.journal","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/pid1.journal","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/filesystem.info","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/journals/customcluster.service","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/generated/installed_packages.log","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-08T15:13:55Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/journals/crio.service","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-08T15:13:56Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/1555/artifacts/journals/systemd-journald.service","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-08T15:13:56Z"}
{"component":"gcsupload","dest":"logs/ami_build_origin_int_rhel_crio/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-12-08T15:13:56Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:78","func":"k8s.io/test-infra/prow/gcsupload.completeUpload","level":"info","msg":"Finished upload to blob storage","severity":"info","time":"2021-12-08T15:13:56Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:78","func":"k8s.io/test-infra/prow/gcsupload.completeUpload","level":"info","msg":"Finished upload to blob storage","severity":"info","time":"2021-12-08T15:13:56Z"}
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 04s] ##########
[workspace] $ /bin/bash /tmp/jenkins3712458629011724173.sh
########## STARTING STAGE: DEPROVISION CLOUD RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/activate ]]
+ source /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config
+ oct deprovision

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

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

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

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

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

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

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

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

TASK [tear down the EC2 instance] **********************************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:15
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2021-12-08 10:14:00.825443", 
    "instance_ids": [
        "i-0d616fd5a2893e04c"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-015941b6e9d5322b2"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0a707fa64c5325c32"
                }
            }, 
            "dns_name": "ec2-3-81-84-98.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-0d616fd5a2893e04c", 
            "image_id": "ami-091b42e4671c5769a", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "openshift-dev", 
            "launch_time": "2021-12-08T14:42:05.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-0-229.ec2.internal", 
            "private_ip": "172.18.0.229", 
            "public_dns_name": "ec2-3-81-84-98.compute-1.amazonaws.com", 
            "public_ip": "3.81.84.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-12-08 10:14:01.082200", 
    "path": "/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.0.229.yml", 
    "state": "absent"
}

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

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

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

TASK [remove inventory configuration directory] ********************************
task path: /var/lib/jenkins/origin-ci-tool/95a472392910104fc805c4ab8af39791105c956d/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:61
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2021-12-08 10:14:01.587346", 
    "path": "/var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/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/ami_build_origin_int_rhel_crio/workspace/artifacts/generated/avc_denials.log, /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/artifacts/generated/installed_packages.log, /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/gcs/artifacts/generated/avc_denials.log, /var/lib/jenkins/jobs/ami_build_origin_int_rhel_crio/workspace/gcs/artifacts/generated/installed_packages.log] to splunk in 4 events
[WS-CLEANUP] Deleting project workspace...
[WS-CLEANUP] Deferred wipeout is used...
[WS-CLEANUP] done
Finished: FAILURE