Console Output

Skipping 535 KB.. Full Log
PLAY RECAP *********************************************************************
localhost                  : ok=35   changed=26   unreachable=0    failed=1    skipped=37   rescued=0    ignored=0   

++ export status=FAILURE
++ status=FAILURE
+ set +o xtrace
########## FINISHED STAGE: FAILURE: RUN THE CRI-O CRITEST TESTS [00h 05m 59s] ##########
Build step 'Execute shell' marked build as failure
[PostBuildScript] - [INFO] Executing post build scripts.
[workspace] $ /bin/bash /tmp/jenkins1138458364226291293.sh
########## STARTING STAGE: DOWNLOAD ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_critest_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_critest_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/gathered
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/gathered
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_critest_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_critest_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_critest_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_critest_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_critest_fedora/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/test_pull_request_crio_critest_fedora/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/test_pull_request_crio_critest_fedora/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/test_pull_request_crio_critest_fedora/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/test_pull_request_crio_critest_fedora/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/test_pull_request_crio_critest_fedora/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/test_pull_request_crio_critest_fedora/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/test_pull_request_crio_critest_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /etc/crio/crio.conf
  File: /etc/crio/crio.conf
  Size: 23652     	Blocks: 48         IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 659760      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:container_config_t:s0
Access: 2022-07-01 21:37:45.151158162 +0000
Modify: 2022-07-01 21:36:11.962170516 +0000
Change: 2022-07-01 21:36:11.962170516 +0000
 Birth: 2022-07-01 21:36:11.962170516 +0000
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_critest_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_critest_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/etc/crio/crio.conf /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/gathered
+ tree /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/gathered
/var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/gathered
└── crio.conf

0 directories, 1 file
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins328153381651756218.sh
########## STARTING STAGE: GENERATE ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_critest_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_critest_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/generated
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/generated
+ mkdir /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/generated
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_critest_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_critest_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_critest_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_critest_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_critest_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_critest_fedora/workspace/artifacts/generated
/var/lib/jenkins/jobs/test_pull_request_crio_critest_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/jenkins8657642689666952281.sh
########## STARTING STAGE: FETCH SYSTEMD JOURNALS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_critest_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_critest_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/journals
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/journals
+ mkdir /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/journals
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_critest_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_critest_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_critest_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_critest_fedora/workspace/artifacts/journals
/var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/journals
├── crio.service
├── customcluster.service
└── systemd-journald.service

0 directories, 3 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins8810193769760617210.sh
########## STARTING STAGE: CREATE /DATA, INSTALL JQ, DOCKER, AND START DOCKERD ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_critest_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_critest_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config
++ mktemp
+ script=/tmp/tmp.VTojBXmpLW
+ cat
+ chmod +x /tmp/tmp.VTojBXmpLW
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.VTojBXmpLW openshiftdevel:/tmp/tmp.VTojBXmpLW
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.VTojBXmpLW"'
+ 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
Fedora Modular 30 - x86_64                       89 kB/s | 2.8 kB     00:00    
Fedora Modular 30 - x86_64 - Updates             12 kB/s | 2.7 kB     00:00    
Fedora 30 - x86_64 - Updates                     53 kB/s | 2.8 kB     00:00    
Fedora 30 - x86_64                               57 kB/s | 2.8 kB     00:00    
Dependencies resolved.
================================================================================
 Package                   Arch   Version                         Repo     Size
================================================================================
Installing:
 jq                        x86_64 1.6-2.fc30                      fedora  168 k
 podman-docker             noarch 2:1.8.0-4.fc30                  updates  71 k
Installing dependencies:
 conmon                    x86_64 2:2.0.13-1.fc30                 updates  38 k
 containernetworking-plugins
                           x86_64 0.8.5-1.fc30                    updates  20 M
 fuse3                     x86_64 3.6.2-1.fc30                    updates  53 k
 fuse3-libs                x86_64 3.6.2-1.fc30                    updates  88 k
 libbsd                    x86_64 0.9.1-3.fc30                    fedora  100 k
 libnet                    x86_64 1.1.6-17.fc30                   fedora   61 k
 libnftnl                  x86_64 1.1.3-1.fc30                    updates  71 k
 nftables                  x86_64 1:0.9.1-2.fc30                  updates 289 k
 oniguruma                 x86_64 6.9.2-4.fc30                    updates 198 k
 podman                    x86_64 2:1.8.0-4.fc30                  updates  13 M
 podman-plugins            x86_64 2:1.8.0-4.fc30                  updates 1.3 M
 protobuf-c                x86_64 1.3.1-2.fc30                    fedora   33 k
Installing weak dependencies:
 criu                      x86_64 3.13-5.fc30                     updates 482 k
 fuse-overlayfs            x86_64 0.7.5-2.fc30                    updates  62 k
 libvarlink-util           x86_64 18-1.fc30                       updates  47 k
 runc                      x86_64 2:1.0.0-102.dev.gitdc9208a.fc30 updates 2.7 M
 slirp4netns               x86_64 0.4.0-4.git19d199a.fc30         updates  85 k

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

Total download size: 39 M
Installed size: 150 M
Downloading Packages:
(1/19): conmon-2.0.13-1.fc30.x86_64.rpm         1.1 MB/s |  38 kB     00:00    
(2/19): fuse-overlayfs-0.7.5-2.fc30.x86_64.rpm  9.9 MB/s |  62 kB     00:00    
(3/19): criu-3.13-5.fc30.x86_64.rpm              10 MB/s | 482 kB     00:00    
(4/19): fuse3-3.6.2-1.fc30.x86_64.rpm           9.1 MB/s |  53 kB     00:00    
(5/19): fuse3-libs-3.6.2-1.fc30.x86_64.rpm       14 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    9.5 MB/s |  47 kB     00:00    
(8/19): nftables-0.9.1-2.fc30.x86_64.rpm         26 MB/s | 289 kB     00:00    
(9/19): oniguruma-6.9.2-4.fc30.x86_64.rpm       5.0 MB/s | 198 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  20 MB/s | 1.3 MB     00:00    
(12/19): runc-1.0.0-102.dev.gitdc9208a.fc30.x86  13 MB/s | 2.7 MB     00:00    
(13/19): slirp4netns-0.4.0-4.git19d199a.fc30.x8 987 kB/s |  85 kB     00:00    
(14/19): podman-1.8.0-4.fc30.x86_64.rpm          27 MB/s |  13 MB     00:00    
(15/19): jq-1.6-2.fc30.x86_64.rpm               1.6 MB/s | 168 kB     00:00    
(16/19): libnet-1.1.6-17.fc30.x86_64.rpm        9.5 MB/s |  61 kB     00:00    
(17/19): libbsd-0.9.1-3.fc30.x86_64.rpm         9.8 MB/s | 100 kB     00:00    
(18/19): protobuf-c-1.3.1-2.fc30.x86_64.rpm     5.0 MB/s |  33 kB     00:00    
(19/19): containernetworking-plugins-0.8.5-1.fc  26 MB/s |  20 MB     00:00    
--------------------------------------------------------------------------------
Total                                            44 MB/s |  39 MB     00:00     
Running transaction check
Transaction check succeeded.
Running transaction test
Transaction test succeeded.
Running transaction
  Preparing        :                                                        1/1 
  Installing       : fuse3-libs-3.6.2-1.fc30.x86_64                        1/19 
  Installing       : fuse3-3.6.2-1.fc30.x86_64                             2/19 
  Installing       : fuse-overlayfs-0.7.5-2.fc30.x86_64                    3/19 
  Running scriptlet: fuse-overlayfs-0.7.5-2.fc30.x86_64                    3/19 
  Installing       : protobuf-c-1.3.1-2.fc30.x86_64                        4/19 
  Installing       : libnet-1.1.6-17.fc30.x86_64                           5/19 
  Installing       : libbsd-0.9.1-3.fc30.x86_64                            6/19 
  Installing       : criu-3.13-5.fc30.x86_64                               7/19 
  Installing       : runc-2:1.0.0-102.dev.gitdc9208a.fc30.x86_64           8/19 
  Installing       : slirp4netns-0.4.0-4.git19d199a.fc30.x86_64            9/19 
  Installing       : podman-plugins-2:1.8.0-4.fc30.x86_64                 10/19 
  Installing       : oniguruma-6.9.2-4.fc30.x86_64                        11/19 
  Installing       : libvarlink-util-18-1.fc30.x86_64                     12/19 
  Installing       : libnftnl-1.1.3-1.fc30.x86_64                         13/19 
  Installing       : nftables-1:0.9.1-2.fc30.x86_64                       14/19 
  Running scriptlet: nftables-1:0.9.1-2.fc30.x86_64                       14/19 
  Installing       : containernetworking-plugins-0.8.5-1.fc30.x86_64      15/19 
  Installing       : conmon-2:2.0.13-1.fc30.x86_64                        16/19 
  Installing       : podman-2:1.8.0-4.fc30.x86_64                         17/19 
  Installing       : podman-docker-2:1.8.0-4.fc30.noarch                  18/19 
  Installing       : jq-1.6-2.fc30.x86_64                                 19/19 
  Running scriptlet: jq-1.6-2.fc30.x86_64                                 19/19 
  Verifying        : conmon-2:2.0.13-1.fc30.x86_64                         1/19 
  Verifying        : containernetworking-plugins-0.8.5-1.fc30.x86_64       2/19 
  Verifying        : criu-3.13-5.fc30.x86_64                               3/19 
  Verifying        : fuse-overlayfs-0.7.5-2.fc30.x86_64                    4/19 
  Verifying        : fuse3-3.6.2-1.fc30.x86_64                             5/19 
  Verifying        : fuse3-libs-3.6.2-1.fc30.x86_64                        6/19 
  Verifying        : libnftnl-1.1.3-1.fc30.x86_64                          7/19 
  Verifying        : libvarlink-util-18-1.fc30.x86_64                      8/19 
  Verifying        : nftables-1:0.9.1-2.fc30.x86_64                        9/19 
  Verifying        : oniguruma-6.9.2-4.fc30.x86_64                        10/19 
  Verifying        : podman-2:1.8.0-4.fc30.x86_64                         11/19 
  Verifying        : podman-docker-2:1.8.0-4.fc30.noarch                  12/19 
  Verifying        : podman-plugins-2:1.8.0-4.fc30.x86_64                 13/19 
  Verifying        : runc-2:1.0.0-102.dev.gitdc9208a.fc30.x86_64          14/19 
  Verifying        : slirp4netns-0.4.0-4.git19d199a.fc30.x86_64           15/19 
  Verifying        : jq-1.6-2.fc30.x86_64                                 16/19 
  Verifying        : libbsd-0.9.1-3.fc30.x86_64                           17/19 
  Verifying        : libnet-1.1.6-17.fc30.x86_64                          18/19 
  Verifying        : protobuf-c-1.3.1-2.fc30.x86_64                       19/19 

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

Complete!
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: CREATE /DATA, INSTALL JQ, DOCKER, AND START DOCKERD [00h 00m 34s] ##########
[workspace] $ /bin/bash /tmp/jenkins2211852946876508448.sh
########## STARTING STAGE: ASSEMBLE GCS OUTPUT ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_critest_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_critest_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_critest_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_critest_fedora/25840/api/json'\''))['\''result'\'']'
+ result=FAILURE
+ cat
++ date +%s
+ cat /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/builds/25840/log
+ cp -r artifacts/gathered/crio.conf 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_critest_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config -r /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/gcs openshiftdevel:/data
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_critest_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/jenkins1505810626464794609.sh
########## STARTING STAGE: PUSH THE ARTIFACTS AND METADATA ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_critest_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_critest_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config
++ mktemp
+ script=/tmp/tmp.CTHH87Jxh5
+ cat
+ chmod +x /tmp/tmp.CTHH87Jxh5
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.CTHH87Jxh5 openshiftdevel:/tmp/tmp.CTHH87Jxh5
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.CTHH87Jxh5"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ [[ -n {"type":"presubmit","job":"test_pull_request_crio_critest_fedora","buildid":"1542983841315033088","prowjobid":"de5af72c-f984-11ec-8a74-0a580a810a70","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"957382974af915dc096a8e6f0e993ab2f8f504e6","base_link":"https://github.com/cri-o/cri-o/commit/957382974af915dc096a8e6f0e993ab2f8f504e6","pulls":[{"number":6026,"author":"haircommander","sha":"948b78d0750859f03958c05afb84e340c080aae7","title":"oci/server: store container status in the container object","link":"https://github.com/cri-o/cri-o/pull/6026","commit_link":"https://github.com/cri-o/cri-o/pull/6026/commits/948b78d0750859f03958c05afb84e340c080aae7","author_link":"https://github.com/haircommander"}]}} ]]
++ jq --compact-output '.buildid |= "25840"'
+ JOB_SPEC='{"type":"presubmit","job":"test_pull_request_crio_critest_fedora","buildid":"25840","prowjobid":"de5af72c-f984-11ec-8a74-0a580a810a70","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"957382974af915dc096a8e6f0e993ab2f8f504e6","base_link":"https://github.com/cri-o/cri-o/commit/957382974af915dc096a8e6f0e993ab2f8f504e6","pulls":[{"number":6026,"author":"haircommander","sha":"948b78d0750859f03958c05afb84e340c080aae7","title":"oci/server: store container status in the container object","link":"https://github.com/cri-o/cri-o/pull/6026","commit_link":"https://github.com/cri-o/cri-o/pull/6026/commits/948b78d0750859f03958c05afb84e340c080aae7","author_link":"https://github.com/haircommander"}]}}'
+ sudo docker run -e 'JOB_SPEC={"type":"presubmit","job":"test_pull_request_crio_critest_fedora","buildid":"25840","prowjobid":"de5af72c-f984-11ec-8a74-0a580a810a70","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"957382974af915dc096a8e6f0e993ab2f8f504e6","base_link":"https://github.com/cri-o/cri-o/commit/957382974af915dc096a8e6f0e993ab2f8f504e6","pulls":[{"number":6026,"author":"haircommander","sha":"948b78d0750859f03958c05afb84e340c080aae7","title":"oci/server: store container status in the container object","link":"https://github.com/cri-o/cri-o/pull/6026","commit_link":"https://github.com/cri-o/cri-o/pull/6026/commits/948b78d0750859f03958c05afb84e340c080aae7","author_link":"https://github.com/haircommander"}]}}' -v /data:/data:z registry.ci.openshift.org/ci/gcsupload:latest --dry-run=false --gcs-path=gs://origin-federated-results --gcs-credentials-file=/data/credentials.json /data/gcs/artifacts /data/gcs/build-log.txt /data/gcs/finished.json /data/gcs/started.json
Emulate Docker CLI using podman. Create /etc/containers/nodocker to quiet msg.
Trying to pull registry.ci.openshift.org/ci/gcsupload:latest...
Getting image source signatures
Copying blob sha256:2f6dd3e597fd08aa69110082ef74791f69e1fc67bff865b1b47f38416242c601
Copying blob sha256:809b39f1848ee7cb2dbba3bff7065c1997cd5b19424d2e33ce139262d43a8887
Copying blob sha256:df20fa9351a15782c64e6dddb2d4a6f50bf6d3688060a34c4014b0d9a752eb4c
Copying blob sha256:250c06f7c38e52dc77e5c7586c3e40280dc7ff9bb9007c396e06d96736cf8542
Copying config sha256:5d7c334da5055a7f97ad6b82a951c40daa785207a80e58dc5b10f6c34776ae13
Writing manifest to image destination
Storing signatures
{"component":"gcsupload","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","file":"k8s.io/test-infra/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/6026/test_pull_request_crio_critest_fedora/25840/artifacts/crio.conf\n","severity":"info","time":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","file":"k8s.io/test-infra/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/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/avc_denials.log\n","severity":"info","time":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","file":"k8s.io/test-infra/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/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/filesystem.info\n","severity":"info","time":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","file":"k8s.io/test-infra/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/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/installed_packages.log\n","severity":"info","time":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","file":"k8s.io/test-infra/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/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/pid1.journal\n","severity":"info","time":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","file":"k8s.io/test-infra/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/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/system.journal\n","severity":"info","time":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","file":"k8s.io/test-infra/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/6026/test_pull_request_crio_critest_fedora/25840/artifacts/journals/crio.service\n","severity":"info","time":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","file":"k8s.io/test-infra/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/6026/test_pull_request_crio_critest_fedora/25840/artifacts/journals/customcluster.service\n","severity":"info","time":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","file":"k8s.io/test-infra/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/6026/test_pull_request_crio_critest_fedora/25840/artifacts/journals/systemd-journald.service\n","severity":"info","time":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/latest-build.txt","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/crio.conf","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/avc_denials.log","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/started.json","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_critest_fedora/25840.txt","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_critest_fedora/latest-build.txt","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/installed_packages.log","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/journals/customcluster.service","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/filesystem.info","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/pid1.journal","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/journals/crio.service","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/system.journal","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/journals/systemd-journald.service","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/build-log.txt","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/finished.json","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/avc_denials.log","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/finished.json","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/latest-build.txt","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_critest_fedora/latest-build.txt","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/crio.conf","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_critest_fedora/25840.txt","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/journals/crio.service","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/installed_packages.log","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/journals/customcluster.service","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/started.json","file":"k8s.io/test-infra/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":"2022-07-01T21:39:10Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/filesystem.info","file":"k8s.io/test-infra/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":"2022-07-01T21:39:11Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/pid1.journal","file":"k8s.io/test-infra/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":"2022-07-01T21:39:11Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/build-log.txt","file":"k8s.io/test-infra/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":"2022-07-01T21:39:11Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/generated/system.journal","file":"k8s.io/test-infra/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":"2022-07-01T21:39:11Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/6026/test_pull_request_crio_critest_fedora/25840/artifacts/journals/systemd-journald.service","file":"k8s.io/test-infra/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":"2022-07-01T21:39:11Z"}
{"component":"gcsupload","file":"k8s.io/test-infra/prow/gcsupload/run.go:78","func":"k8s.io/test-infra/prow/gcsupload.completeUpload","level":"info","msg":"Finished upload to blob storage","severity":"info","time":"2022-07-01T21:39:11Z"}
{"component":"gcsupload","file":"k8s.io/test-infra/prow/gcsupload/run.go:78","func":"k8s.io/test-infra/prow/gcsupload.completeUpload","level":"info","msg":"Finished upload to blob storage","severity":"info","time":"2022-07-01T21:39:11Z"}
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 05s] ##########
[workspace] $ /bin/bash /tmp/jenkins6597255596934113829.sh
########## STARTING STAGE: DEPROVISION CLOUD RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_crio_critest_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_critest_fedora/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_crio_critest_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": "2022-07-01 17:39:12.414173", 
    "item": "origin_ci_inventory_dir", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_region)  => {
    "changed": false, 
    "generated_timestamp": "2022-07-01 17:39:12.417719", 
    "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": "2022-07-01 17:39:13.256419", 
    "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": "2022-07-01 17:39:13.905671", 
    "msg": "Tags {'Name': 'oct-terminate'} created for resource i-02def3a961e6e53c0."
}

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": "2022-07-01 17:39:15.005811", 
    "instance_ids": [
        "i-02def3a961e6e53c0"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-077ac31809a575f05"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0f25f7b3a49b5556a"
                }
            }, 
            "dns_name": "ec2-54-224-26-6.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-02def3a961e6e53c0", 
            "image_id": "ami-038b90348c4438d19", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "openshift-dev", 
            "launch_time": "2022-07-01T21:30:42.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-8-86.ec2.internal", 
            "private_ip": "172.18.8.86", 
            "public_dns_name": "ec2-54-224-26-6.compute-1.amazonaws.com", 
            "public_ip": "54.224.26.6", 
            "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": "2022-07-01 17:39:15.265190", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.8.86.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": "2022-07-01 17:39:15.773275", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_critest_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 04s] ##########
Archiving artifacts
Recording test results
[Checks API] No suitable checks publisher found.
sent [/var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/generated/avc_denials.log, /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/artifacts/generated/installed_packages.log, /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/gcs/artifacts/generated/avc_denials.log, /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/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