Console Output

Skipping 416 KB.. Full Log
META: ran handlers
META: ran handlers

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

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

PLAY RECAP *********************************************************************
localhost                  : ok=39   changed=30   unreachable=0    failed=0    skipped=37   rescued=0    ignored=0   

+ set +o xtrace
########## FINISHED STAGE: SUCCESS: RUN THE CRI-O CRITEST TESTS [00h 09m 59s] ##########
[PostBuildScript] - [INFO] Executing post build scripts.
[workspace] $ /bin/bash /tmp/jenkins1227973532553658641.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/*'
  File: /tmp/artifacts/junit_.xml
  Size: 19016     	Blocks: 40         IO Block: 4096   regular file
Device: ca01h/51713d	Inode: 925978      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2021-11-29 14:50:24.037532024 +0000
Modify: 2021-11-29 14:50:24.038531984 +0000
Change: 2021-11-29 14:50:24.038531984 +0000
 Birth: 2021-11-29 14:50:24.037532024 +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 '/tmp/artifacts/*'
+ scp -r -F /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config 'openshiftdevel:/tmp/artifacts/*' /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 /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: 0         	Blocks: 0          IO Block: 4096   regular empty file
Device: ca01h/51713d	Inode: 798350      Links: 1
Access: (0644/-rw-r--r--)  Uid: (    0/    root)   Gid: (    0/    root)
Context: unconfined_u:object_r:container_config_t:s0
Access: 2021-11-29 14:46:15.588421708 +0000
Modify: 2021-11-29 14:44:24.618372918 +0000
Change: 2021-11-29 14:44:24.618372918 +0000
 Birth: 2021-11-29 14:44:24.618372918 +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
└── junit_.xml

0 directories, 2 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins8093357588610880345.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/jenkins5331427605388307590.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/jenkins6175964053560702277.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.OqT62SSN01
+ cat
+ chmod +x /tmp/tmp.OqT62SSN01
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.OqT62SSN01 openshiftdevel:/tmp/tmp.OqT62SSN01
+ 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.OqT62SSN01"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ sudo mkdir -p /data/gcs
+ sudo chown -R origin:origin /data
+ grep -q 'ID="centos"' /etc/os-release
+ grep -q 'ID="rhel"' /etc/os-release
+ sudo dnf install -y jq podman-docker
Last metadata expiration check: 0:01:16 ago on Mon 29 Nov 2021 02:49:51 PM UTC.
Dependencies resolved.
================================================================================
 Package                   Arch   Version                         Repo     Size
================================================================================
Installing:
 jq                        x86_64 1.6-2.fc30                      fedora  168 k
 podman-docker             noarch 2:1.8.0-4.fc30                  updates  71 k
Installing dependencies:
 conmon                    x86_64 2:2.0.13-1.fc30                 updates  38 k
 containernetworking-plugins
                           x86_64 0.8.5-1.fc30                    updates  20 M
 fuse3                     x86_64 3.6.2-1.fc30                    updates  53 k
 fuse3-libs                x86_64 3.6.2-1.fc30                    updates  88 k
 libbsd                    x86_64 0.9.1-3.fc30                    fedora  100 k
 libnet                    x86_64 1.1.6-17.fc30                   fedora   61 k
 libnftnl                  x86_64 1.1.3-1.fc30                    updates  71 k
 nftables                  x86_64 1:0.9.1-2.fc30                  updates 289 k
 oniguruma                 x86_64 6.9.2-4.fc30                    updates 198 k
 podman                    x86_64 2:1.8.0-4.fc30                  updates  13 M
 podman-plugins            x86_64 2:1.8.0-4.fc30                  updates 1.3 M
 protobuf-c                x86_64 1.3.1-2.fc30                    fedora   33 k
Installing weak dependencies:
 criu                      x86_64 3.13-5.fc30                     updates 482 k
 fuse-overlayfs            x86_64 0.7.5-2.fc30                    updates  62 k
 libvarlink-util           x86_64 18-1.fc30                       updates  47 k
 runc                      x86_64 2:1.0.0-102.dev.gitdc9208a.fc30 updates 2.7 M
 slirp4netns               x86_64 0.4.0-4.git19d199a.fc30         updates  85 k

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

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

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

Complete!
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: CREATE /DATA, INSTALL JQ, DOCKER, AND START DOCKERD [00h 00m 15s] ##########
[workspace] $ /bin/bash /tmp/jenkins8787176915939058192.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/24198/api/json'\''))['\''result'\'']'
+ result=SUCCESS
+ cat
++ date +%s
+ cat /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/builds/24198/log
+ cp -r artifacts/gathered/crio.conf artifacts/gathered/junit_.xml 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/jenkins5221081756218650348.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.iLolOvvhUw
+ cat
+ chmod +x /tmp/tmp.iLolOvvhUw
+ scp -F /var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.iLolOvvhUw openshiftdevel:/tmp/tmp.iLolOvvhUw
+ 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.iLolOvvhUw"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ [[ -n {"type":"presubmit","job":"test_pull_request_crio_critest_fedora","buildid":"1465329273681219584","prowjobid":"e86f47dd-5121-11ec-8109-0a580a810c22","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"7048f2440217bbb2d6b5b7cfdbad052a4b8527f1","base_link":"https://github.com/cri-o/cri-o/commit/7048f2440217bbb2d6b5b7cfdbad052a4b8527f1","pulls":[{"number":5473,"author":"rockmenjack","sha":"2811bd6afea913deb176acd667b904978c273e81","title":"update go to 1.16 in go.mod","link":"https://github.com/cri-o/cri-o/pull/5473","commit_link":"https://github.com/cri-o/cri-o/pull/5473/commits/2811bd6afea913deb176acd667b904978c273e81","author_link":"https://github.com/rockmenjack"}]}} ]]
++ jq --compact-output '.buildid |= "24198"'
+ JOB_SPEC='{"type":"presubmit","job":"test_pull_request_crio_critest_fedora","buildid":"24198","prowjobid":"e86f47dd-5121-11ec-8109-0a580a810c22","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"7048f2440217bbb2d6b5b7cfdbad052a4b8527f1","base_link":"https://github.com/cri-o/cri-o/commit/7048f2440217bbb2d6b5b7cfdbad052a4b8527f1","pulls":[{"number":5473,"author":"rockmenjack","sha":"2811bd6afea913deb176acd667b904978c273e81","title":"update go to 1.16 in go.mod","link":"https://github.com/cri-o/cri-o/pull/5473","commit_link":"https://github.com/cri-o/cri-o/pull/5473/commits/2811bd6afea913deb176acd667b904978c273e81","author_link":"https://github.com/rockmenjack"}]}}'
+ sudo docker run -e 'JOB_SPEC={"type":"presubmit","job":"test_pull_request_crio_critest_fedora","buildid":"24198","prowjobid":"e86f47dd-5121-11ec-8109-0a580a810c22","refs":{"org":"cri-o","repo":"cri-o","repo_link":"https://github.com/cri-o/cri-o","base_ref":"main","base_sha":"7048f2440217bbb2d6b5b7cfdbad052a4b8527f1","base_link":"https://github.com/cri-o/cri-o/commit/7048f2440217bbb2d6b5b7cfdbad052a4b8527f1","pulls":[{"number":5473,"author":"rockmenjack","sha":"2811bd6afea913deb176acd667b904978c273e81","title":"update go to 1.16 in go.mod","link":"https://github.com/cri-o/cri-o/pull/5473","commit_link":"https://github.com/cri-o/cri-o/pull/5473/commits/2811bd6afea913deb176acd667b904978c273e81","author_link":"https://github.com/rockmenjack"}]}}' -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:df20fa9351a15782c64e6dddb2d4a6f50bf6d3688060a34c4014b0d9a752eb4c
Copying blob sha256:809b39f1848ee7cb2dbba3bff7065c1997cd5b19424d2e33ce139262d43a8887
Copying blob sha256:85cea451eec057fa7e734548ca3ba6d779ed5836a3f9de14b8394575ef0d7d8e
Copying blob sha256:519c3f86e24c3dc13a5cb709eb1c6368cda78aa5d925e4430134b691154902a1
Copying config sha256:5e13917392142d8941efdd5f3e3cc0e95110523232660ea453b853bfc528e2f6
Writing manifest to image destination
Storing signatures
{"component":"gcsupload","file":"prow/gcsupload/run.go:194","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts","level":"info","msg":"Gathering artifacts from artifact directory: /data/gcs/artifacts","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/crio.conf in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/crio.conf\n","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/avc_denials.log in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/generated/avc_denials.log\n","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/filesystem.info in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/generated/filesystem.info\n","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/installed_packages.log in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/generated/installed_packages.log\n","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/pid1.journal in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/generated/pid1.journal\n","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/generated/system.journal in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/generated/system.journal\n","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/journals/crio.service in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/journals/crio.service\n","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/journals/customcluster.service in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/journals/customcluster.service\n","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/journals/systemd-journald.service in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/journals/systemd-journald.service\n","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","file":"prow/gcsupload/run.go:212","func":"k8s.io/test-infra/prow/gcsupload.gatherArtifacts.func1","level":"info","msg":"Found /data/gcs/artifacts/junit_.xml in artifact directory. Uploading as pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/junit_.xml\n","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_critest_fedora/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/junit_.xml","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/crio.conf","file":"prow/pod-utils/gcs/upload.go:86","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload","level":"info","msg":"Queued for upload","severity":"info","time":"2021-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_critest_fedora/24198.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-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:24Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/crio.conf","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/artifacts/junit_.xml","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_critest_fedora/latest-build.txt","file":"prow/pod-utils/gcs/upload.go:114","func":"k8s.io/test-infra/prow/pod-utils/gcs.upload.func1","level":"info","msg":"Finished upload","severity":"info","time":"2021-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_crio_critest_fedora/24198.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-11-29T14:51:25Z"}
{"component":"gcsupload","dest":"pr-logs/pull/cri-o_cri-o/5473/test_pull_request_crio_critest_fedora/24198/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-11-29T14:51:25Z"}
{"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-11-29T14:51:25Z"}
{"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-11-29T14:51:25Z"}
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 05s] ##########
[workspace] $ /bin/bash /tmp/jenkins5320390060041203201.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": "2021-11-29 09:51:27.125404", 
    "item": "origin_ci_inventory_dir", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_region)  => {
    "changed": false, 
    "generated_timestamp": "2021-11-29 09:51:27.129215", 
    "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-11-29 09:51:28.048798", 
    "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-11-29 09:51:29.234830", 
    "msg": "Tags {'Name': 'oct-terminate'} created for resource i-0739bb2a87fd567d8."
}

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-11-29 09:51:30.468226", 
    "instance_ids": [
        "i-0739bb2a87fd567d8"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0d1abf9ef221f5f39"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0e2422153f7f67d73"
                }
            }, 
            "dns_name": "ec2-54-162-34-140.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-0739bb2a87fd567d8", 
            "image_id": "ami-038b90348c4438d19", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "openshift-dev", 
            "launch_time": "2021-11-29T14:38:58.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-6-200.ec2.internal", 
            "private_ip": "172.18.6.200", 
            "public_dns_name": "ec2-54-162-34-140.compute-1.amazonaws.com", 
            "public_ip": "54.162.34.140", 
            "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-11-29 09:51:30.796021", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_crio_critest_fedora/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.6.200.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-11-29 09:51:31.340794", 
    "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 06s] ##########
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: SUCCESS